{"level":"warn","ts":"2026-05-05T16:52:30.286482Z","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-05T16:52:30.286585Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.141: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.141:2380","--initial-cluster=instance=https://199.19.213.141:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.141:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.141: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-05T16:52:30.28683Z","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-05T16:52:30.286853Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.141:2380"]} {"level":"info","ts":"2026-05-05T16:52:30.287001Z","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-05T16:52:30.28793Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.141:2379"]} {"level":"info","ts":"2026-05-05T16:52:30.288139Z","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.141:2380"],"listen-peer-urls":["https://199.19.213.141:2380"],"advertise-client-urls":["https://199.19.213.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.141: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-05T16:52:30.291997Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.496847ms"} {"level":"info","ts":"2026-05-05T16:52:30.300551Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe263d225de0d201","cluster-id":"24f15cf84c3a7bc3"} {"level":"info","ts":"2026-05-05T16:52:30.300739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T16:52:30.300772Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became follower at term 0"} {"level":"info","ts":"2026-05-05T16:52:30.300864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe263d225de0d201 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T16:52:30.300879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became follower at term 1"} {"level":"info","ts":"2026-05-05T16:52:30.301039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=(18313392152561897985)"} {"level":"warn","ts":"2026-05-05T16:52:30.306137Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T16:52:30.307963Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T16:52:30.310207Z","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-05T16:52:30.31315Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe263d225de0d201","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T16:52:30.314192Z","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-05T16:52:30.314317Z","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-05T16:52:30.314332Z","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-05T16:52:30.313924Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe263d225de0d201","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T16:52:30.314847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=(18313392152561897985)"} {"level":"info","ts":"2026-05-05T16:52:30.315335Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"24f15cf84c3a7bc3","local-member-id":"fe263d225de0d201","added-peer-id":"fe263d225de0d201","added-peer-peer-urls":["https://199.19.213.141:2380"]} {"level":"info","ts":"2026-05-05T16:52:30.317664Z","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-05T16:52:30.317755Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.141:2380"} {"level":"info","ts":"2026-05-05T16:52:30.317832Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.141:2380"} {"level":"info","ts":"2026-05-05T16:52:30.31791Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe263d225de0d201","initial-advertise-peer-urls":["https://199.19.213.141:2380"],"listen-peer-urls":["https://199.19.213.141:2380"],"advertise-client-urls":["https://199.19.213.141:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.141:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T16:52:30.317958Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T16:52:31.102381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T16:52:31.102467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T16:52:31.102493Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 received MsgPreVoteResp from fe263d225de0d201 at term 1"} {"level":"info","ts":"2026-05-05T16:52:31.102513Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became candidate at term 2"} {"level":"info","ts":"2026-05-05T16:52:31.102524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 received MsgVoteResp from fe263d225de0d201 at term 2"} {"level":"info","ts":"2026-05-05T16:52:31.10254Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became leader at term 2"} {"level":"info","ts":"2026-05-05T16:52:31.102559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe263d225de0d201 elected leader fe263d225de0d201 at term 2"} {"level":"info","ts":"2026-05-05T16:52:31.108606Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe263d225de0d201","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.141:2379]}","request-path":"/0/members/fe263d225de0d201/attributes","cluster-id":"24f15cf84c3a7bc3","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T16:52:31.108631Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T16:52:31.108657Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T16:52:31.10898Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T16:52:31.109082Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T16:52:31.109264Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T16:52:31.114005Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T16:52:31.115046Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"24f15cf84c3a7bc3","local-member-id":"fe263d225de0d201","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T16:52:31.115233Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T16:52:31.115297Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T16:52:31.115976Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.141:2379"} {"level":"warn","ts":"2026-05-05T16:52:36.475766Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.364074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:52:36.475812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.366819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-05T16:52:36.475886Z","caller":"traceutil/trace.go:171","msg":"trace[1497317857] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:259; }","duration":"130.525979ms","start":"2026-05-05T16:52:36.345341Z","end":"2026-05-05T16:52:36.475867Z","steps":["trace[1497317857] 'range keys from in-memory index tree' (duration: 130.306321ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:52:36.475916Z","caller":"traceutil/trace.go:171","msg":"trace[1562739161] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:259; }","duration":"253.521384ms","start":"2026-05-05T16:52:36.222369Z","end":"2026-05-05T16:52:36.47589Z","steps":["trace[1562739161] 'range keys from in-memory index tree' (duration: 253.039638ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:52:36.80032Z","caller":"traceutil/trace.go:171","msg":"trace[186539376] linearizableReadLoop","detail":"{readStateIndex:268; appliedIndex:267; }","duration":"240.230076ms","start":"2026-05-05T16:52:36.560072Z","end":"2026-05-05T16:52:36.800302Z","steps":["trace[186539376] 'read index received' (duration: 240.156414ms)","trace[186539376] 'applied index is now lower than readState.Index' (duration: 72.782µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T16:52:36.800492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.403902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-05-05T16:52:36.800438Z","caller":"traceutil/trace.go:171","msg":"trace[452588128] transaction","detail":"{read_only:false; response_revision:260; number_of_response:1; }","duration":"321.352611ms","start":"2026-05-05T16:52:36.479012Z","end":"2026-05-05T16:52:36.800365Z","steps":["trace[452588128] 'process raft request' (duration: 321.176725ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:52:36.800522Z","caller":"traceutil/trace.go:171","msg":"trace[719439626] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:260; }","duration":"240.511106ms","start":"2026-05-05T16:52:36.560001Z","end":"2026-05-05T16:52:36.800512Z","steps":["trace[719439626] 'agreement among raft nodes before linearized reading' (duration: 240.399812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:36.800981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:36.47897Z","time spent":"321.570468ms","remote":"127.0.0.1:54438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":190,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T16:52:36.8062Z","caller":"traceutil/trace.go:171","msg":"trace[75817293] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"243.097423ms","start":"2026-05-05T16:52:36.563086Z","end":"2026-05-05T16:52:36.806183Z","steps":["trace[75817293] 'process raft request' (duration: 242.942647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:36.806366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.52763ms","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-05T16:52:36.80648Z","caller":"traceutil/trace.go:171","msg":"trace[1339886992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:260; }","duration":"233.697976ms","start":"2026-05-05T16:52:36.572755Z","end":"2026-05-05T16:52:36.806453Z","steps":["trace[1339886992] 'agreement among raft nodes before linearized reading' (duration: 233.448627ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:52:36.806701Z","caller":"traceutil/trace.go:171","msg":"trace[1092675851] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"243.488286ms","start":"2026-05-05T16:52:36.563201Z","end":"2026-05-05T16:52:36.80669Z","steps":["trace[1092675851] 'process raft request' (duration: 242.902746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:38.87635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.925746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:52:38.87644Z","caller":"traceutil/trace.go:171","msg":"trace[1304820870] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:0; response_revision:287; }","duration":"303.06466ms","start":"2026-05-05T16:52:38.573351Z","end":"2026-05-05T16:52:38.876416Z","steps":["trace[1304820870] 'range keys from in-memory index tree' (duration: 302.795562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:38.876511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:38.57333Z","time spent":"303.171634ms","remote":"127.0.0.1:54438","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-05-05T16:52:39.740238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.13597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-05T16:52:39.7403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.131239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-05T16:52:39.740332Z","caller":"traceutil/trace.go:171","msg":"trace[1557352640] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:293; }","duration":"155.289935ms","start":"2026-05-05T16:52:39.585024Z","end":"2026-05-05T16:52:39.740314Z","steps":["trace[1557352640] 'range keys from in-memory index tree' (duration: 155.030467ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:52:39.740376Z","caller":"traceutil/trace.go:171","msg":"trace[598652393] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:293; }","duration":"517.262073ms","start":"2026-05-05T16:52:39.223097Z","end":"2026-05-05T16:52:39.740359Z","steps":["trace[598652393] 'range keys from in-memory index tree' (duration: 517.015225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:39.740419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:39.223074Z","time spent":"517.337026ms","remote":"127.0.0.1:54358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-05T16:52:46.524122Z","caller":"traceutil/trace.go:171","msg":"trace[264826646] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"151.044477ms","start":"2026-05-05T16:52:46.373053Z","end":"2026-05-05T16:52:46.524098Z","steps":["trace[264826646] 'process raft request' (duration: 150.942513ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:52:52.595298Z","caller":"traceutil/trace.go:171","msg":"trace[692618589] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"222.928513ms","start":"2026-05-05T16:52:52.372345Z","end":"2026-05-05T16:52:52.595273Z","steps":["trace[692618589] 'read index received' (duration: 222.775888ms)","trace[692618589] 'applied index is now lower than readState.Index' (duration: 151.615µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:52:52.595399Z","caller":"traceutil/trace.go:171","msg":"trace[434508862] transaction","detail":"{read_only:false; response_revision:411; number_of_response:1; }","duration":"795.933292ms","start":"2026-05-05T16:52:51.799431Z","end":"2026-05-05T16:52:52.595365Z","steps":["trace[434508862] 'process raft request' (duration: 795.718755ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:52.595451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.089188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-05T16:52:52.595512Z","caller":"traceutil/trace.go:171","msg":"trace[785091130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:411; }","duration":"223.202361ms","start":"2026-05-05T16:52:52.372299Z","end":"2026-05-05T16:52:52.595501Z","steps":["trace[785091130] 'agreement among raft nodes before linearized reading' (duration: 223.091708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:52.595687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.641644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:52:52.595827Z","caller":"traceutil/trace.go:171","msg":"trace[578020296] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:411; }","duration":"215.829791ms","start":"2026-05-05T16:52:52.379978Z","end":"2026-05-05T16:52:52.595808Z","steps":["trace[578020296] 'agreement among raft nodes before linearized reading' (duration: 215.664875ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:52.595839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:51.7994Z","time spent":"796.095107ms","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T16:52:53.520181Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952144538,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T16:52:54.020674Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952144538,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T16:52:54.077817Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.120175968s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T16:52:54.078446Z","caller":"traceutil/trace.go:171","msg":"trace[1284979426] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"1.120891722s","start":"2026-05-05T16:52:52.957516Z","end":"2026-05-05T16:52:54.078407Z","steps":["trace[1284979426] 'process raft request' (duration: 1.120676865s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:54.078616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:52.957499Z","time spent":"1.121011076s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T16:52:54.079648Z","caller":"traceutil/trace.go:171","msg":"trace[3110399] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:426; }","duration":"1.060543487s","start":"2026-05-05T16:52:53.019084Z","end":"2026-05-05T16:52:54.079627Z","steps":["trace[3110399] 'read index received' (duration: 1.059096858s)","trace[3110399] 'applied index is now lower than readState.Index' (duration: 1.445709ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:52:54.079829Z","caller":"traceutil/trace.go:171","msg":"trace[1221251842] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"809.610446ms","start":"2026-05-05T16:52:53.270202Z","end":"2026-05-05T16:52:54.079812Z","steps":["trace[1221251842] 'process raft request' (duration: 809.338837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:54.079938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060808826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-05T16:52:54.07996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:53.270185Z","time spent":"809.6958ms","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T16:52:54.08005Z","caller":"traceutil/trace.go:171","msg":"trace[1710654703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:414; }","duration":"1.0609514s","start":"2026-05-05T16:52:53.019031Z","end":"2026-05-05T16:52:54.079982Z","steps":["trace[1710654703] 'agreement among raft nodes before linearized reading' (duration: 1.060815055s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:54.080249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.671876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:52:54.080289Z","caller":"traceutil/trace.go:171","msg":"trace[657404109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:414; }","duration":"644.751819ms","start":"2026-05-05T16:52:53.435527Z","end":"2026-05-05T16:52:54.080278Z","steps":["trace[657404109] 'agreement among raft nodes before linearized reading' (duration: 644.690807ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:52:54.080325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:53.43551Z","time spent":"644.8088ms","remote":"127.0.0.1:54272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T16:52:54.080305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:52:53.019018Z","time spent":"1.061162968s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T16:52:54.080533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.758896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.141\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T16:52:54.080848Z","caller":"traceutil/trace.go:171","msg":"trace[886880613] range","detail":"{range_begin:/registry/masterleases/199.19.213.141; range_end:; response_count:1; response_revision:414; }","duration":"158.112659ms","start":"2026-05-05T16:52:53.922718Z","end":"2026-05-05T16:52:54.080831Z","steps":["trace[886880613] 'agreement among raft nodes before linearized reading' (duration: 157.774397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:07.353192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.215544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:07.353292Z","caller":"traceutil/trace.go:171","msg":"trace[512594695] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:559; }","duration":"173.363269ms","start":"2026-05-05T16:53:07.179904Z","end":"2026-05-05T16:53:07.353268Z","steps":["trace[512594695] 'range keys from in-memory index tree' (duration: 173.118131ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:10.620092Z","caller":"traceutil/trace.go:171","msg":"trace[859090104] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"188.763913ms","start":"2026-05-05T16:53:10.431314Z","end":"2026-05-05T16:53:10.620077Z","steps":["trace[859090104] 'process raft request' (duration: 188.341318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.159305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.39211ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.159381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.276258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.159426Z","caller":"traceutil/trace.go:171","msg":"trace[405845380] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:585; }","duration":"356.357151ms","start":"2026-05-05T16:53:10.803062Z","end":"2026-05-05T16:53:11.15942Z","steps":["trace[405845380] 'agreement among raft nodes before linearized reading' (duration: 356.267128ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:11.159425Z","caller":"traceutil/trace.go:171","msg":"trace[1863160544] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:584; }","duration":"204.530785ms","start":"2026-05-05T16:53:10.95488Z","end":"2026-05-05T16:53:11.159411Z","steps":["trace[1863160544] 'range keys from in-memory index tree' (duration: 204.37669ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.159449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.803047Z","time spent":"356.396992ms","remote":"127.0.0.1:43974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"info","ts":"2026-05-05T16:53:11.159609Z","caller":"traceutil/trace.go:171","msg":"trace[621562864] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"381.462762ms","start":"2026-05-05T16:53:10.77814Z","end":"2026-05-05T16:53:11.159603Z","steps":["trace[621562864] 'process raft request' (duration: 381.088799ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.159666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.778123Z","time spent":"381.506494ms","remote":"127.0.0.1:54470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T16:53:11.159326Z","caller":"traceutil/trace.go:171","msg":"trace[1669391799] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:605; }","duration":"356.226107ms","start":"2026-05-05T16:53:10.803085Z","end":"2026-05-05T16:53:11.159312Z","steps":["trace[1669391799] 'read index received' (duration: 356.099412ms)","trace[1669391799] 'applied index is now lower than readState.Index' (duration: 126.045µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T16:53:11.159863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.750825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.159894Z","caller":"traceutil/trace.go:171","msg":"trace[1685238608] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:585; }","duration":"356.817797ms","start":"2026-05-05T16:53:10.803063Z","end":"2026-05-05T16:53:11.159881Z","steps":["trace[1685238608] 'agreement among raft nodes before linearized reading' (duration: 356.745455ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.159918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.803049Z","time spent":"356.862248ms","remote":"127.0.0.1:43974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T16:53:11.160035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.695966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.160042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.585919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160054Z","caller":"traceutil/trace.go:171","msg":"trace[927790537] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:585; }","duration":"322.735478ms","start":"2026-05-05T16:53:10.837313Z","end":"2026-05-05T16:53:11.160048Z","steps":["trace[927790537] 'agreement among raft nodes before linearized reading' (duration: 322.703637ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:11.160084Z","caller":"traceutil/trace.go:171","msg":"trace[1055572480] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:585; }","duration":"172.799047ms","start":"2026-05-05T16:53:10.987273Z","end":"2026-05-05T16:53:11.160072Z","steps":["trace[1055572480] 'agreement among raft nodes before linearized reading' (duration: 172.706474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.16237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.160074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.612862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.160111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.964154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160115Z","caller":"traceutil/trace.go:171","msg":"trace[1668194130] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:585; }","duration":"152.231932ms","start":"2026-05-05T16:53:11.007874Z","end":"2026-05-05T16:53:11.160106Z","steps":["trace[1668194130] 'agreement among raft nodes before linearized reading' (duration: 152.138179ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:11.160132Z","caller":"traceutil/trace.go:171","msg":"trace[2009263861] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:585; }","duration":"128.982035ms","start":"2026-05-05T16:53:11.031142Z","end":"2026-05-05T16:53:11.160125Z","steps":["trace[2009263861] 'agreement among raft nodes before linearized reading' (duration: 128.957524ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:11.160126Z","caller":"traceutil/trace.go:171","msg":"trace[1197243129] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:585; }","duration":"170.693405ms","start":"2026-05-05T16:53:10.989418Z","end":"2026-05-05T16:53:11.160111Z","steps":["trace[1197243129] 'agreement among raft nodes before linearized reading' (duration: 170.609602ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.16022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.931335ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.16024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.997233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.160234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.437769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160247Z","caller":"traceutil/trace.go:171","msg":"trace[1048100863] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:585; }","duration":"322.965305ms","start":"2026-05-05T16:53:10.837274Z","end":"2026-05-05T16:53:11.160239Z","steps":["trace[1048100863] 'agreement among raft nodes before linearized reading' (duration: 322.928294ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:11.160259Z","caller":"traceutil/trace.go:171","msg":"trace[882644200] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:585; }","duration":"152.032385ms","start":"2026-05-05T16:53:11.008219Z","end":"2026-05-05T16:53:11.160252Z","steps":["trace[882644200] 'agreement among raft nodes before linearized reading' (duration: 152.006934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.837269Z","time spent":"322.996177ms","remote":"127.0.0.1:43990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T16:53:11.160279Z","caller":"traceutil/trace.go:171","msg":"trace[791658937] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:585; }","duration":"152.4947ms","start":"2026-05-05T16:53:11.007762Z","end":"2026-05-05T16:53:11.160257Z","steps":["trace[791658937] 'agreement among raft nodes before linearized reading' (duration: 152.451769ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.768696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160314Z","caller":"traceutil/trace.go:171","msg":"trace[1672642538] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:585; }","duration":"172.794767ms","start":"2026-05-05T16:53:10.987512Z","end":"2026-05-05T16:53:11.160307Z","steps":["trace[1672642538] 'agreement among raft nodes before linearized reading' (duration: 172.754765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.260176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160396Z","caller":"traceutil/trace.go:171","msg":"trace[1609701906] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:585; }","duration":"323.294977ms","start":"2026-05-05T16:53:10.837095Z","end":"2026-05-05T16:53:11.16039Z","steps":["trace[1609701906] 'agreement among raft nodes before linearized reading' (duration: 323.263546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.16009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.929692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.160415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.83709Z","time spent":"323.319418ms","remote":"127.0.0.1:43990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T16:53:11.160436Z","caller":"traceutil/trace.go:171","msg":"trace[2064369574] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:585; }","duration":"129.292135ms","start":"2026-05-05T16:53:11.031133Z","end":"2026-05-05T16:53:11.160426Z","steps":["trace[2064369574] 'agreement among raft nodes before linearized reading' (duration: 128.942643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.313135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160519Z","caller":"traceutil/trace.go:171","msg":"trace[1014183187] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:585; }","duration":"341.347627ms","start":"2026-05-05T16:53:10.819163Z","end":"2026-05-05T16:53:11.160511Z","steps":["trace[1014183187] 'agreement among raft nodes before linearized reading' (duration: 341.313666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.819144Z","time spent":"341.392678ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-05T16:53:11.160666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.485821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160731Z","caller":"traceutil/trace.go:171","msg":"trace[2097590470] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:585; }","duration":"341.529363ms","start":"2026-05-05T16:53:10.819153Z","end":"2026-05-05T16:53:11.160682Z","steps":["trace[2097590470] 'agreement among raft nodes before linearized reading' (duration: 341.487011ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.837302Z","time spent":"322.778379ms","remote":"127.0.0.1:43990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T16:53:11.160848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.819143Z","time spent":"341.604165ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T16:53:11.160895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.7253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.160914Z","caller":"traceutil/trace.go:171","msg":"trace[1503846855] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:585; }","duration":"341.75636ms","start":"2026-05-05T16:53:10.819152Z","end":"2026-05-05T16:53:11.160908Z","steps":["trace[1503846855] 'agreement among raft nodes before linearized reading' (duration: 341.723819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.160929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.819145Z","time spent":"341.779681ms","remote":"127.0.0.1:43980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-05T16:53:11.160992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.872243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.161016Z","caller":"traceutil/trace.go:171","msg":"trace[908166960] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:585; }","duration":"357.902044ms","start":"2026-05-05T16:53:10.803108Z","end":"2026-05-05T16:53:11.16101Z","steps":["trace[908166960] 'agreement among raft nodes before linearized reading' (duration: 357.868153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.161033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:10.803104Z","time spent":"357.923965ms","remote":"127.0.0.1:43974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T16:53:11.161218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.354306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:53:11.16122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.636865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.161238Z","caller":"traceutil/trace.go:171","msg":"trace[1281506881] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"117.387027ms","start":"2026-05-05T16:53:11.043844Z","end":"2026-05-05T16:53:11.161232Z","steps":["trace[1281506881] 'agreement among raft nodes before linearized reading' (duration: 117.352925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.16126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.123332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.161259Z","caller":"traceutil/trace.go:171","msg":"trace[227901235] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"117.718918ms","start":"2026-05-05T16:53:11.043529Z","end":"2026-05-05T16:53:11.161248Z","steps":["trace[227901235] 'agreement among raft nodes before linearized reading' (duration: 117.656186ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:11.161291Z","caller":"traceutil/trace.go:171","msg":"trace[1193357503] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:585; }","duration":"118.165923ms","start":"2026-05-05T16:53:11.043114Z","end":"2026-05-05T16:53:11.16128Z","steps":["trace[1193357503] 'agreement among raft nodes before linearized reading' (duration: 118.116022ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:11.159999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.628603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:53:11.165423Z","caller":"traceutil/trace.go:171","msg":"trace[1109996697] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:585; }","duration":"132.616709ms","start":"2026-05-05T16:53:11.031338Z","end":"2026-05-05T16:53:11.163955Z","steps":["trace[1109996697] 'agreement among raft nodes before linearized reading' (duration: 128.613822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:26.709391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.571696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nbgdz\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-05T16:53:26.709464Z","caller":"traceutil/trace.go:171","msg":"trace[246323926] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-nbgdz; range_end:; response_count:1; response_revision:746; }","duration":"197.67953ms","start":"2026-05-05T16:53:26.51177Z","end":"2026-05-05T16:53:26.70945Z","steps":["trace[246323926] 'range keys from in-memory index tree' (duration: 197.453303ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:53:40.087805Z","caller":"traceutil/trace.go:171","msg":"trace[1017106620] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"417.200833ms","start":"2026-05-05T16:53:39.670583Z","end":"2026-05-05T16:53:40.087784Z","steps":["trace[1017106620] 'process raft request' (duration: 417.035812ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:40.087984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:39.670542Z","time spent":"417.331735ms","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T16:53:41.263147Z","caller":"traceutil/trace.go:171","msg":"trace[43101332] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"316.008194ms","start":"2026-05-05T16:53:40.947111Z","end":"2026-05-05T16:53:41.263119Z","steps":["trace[43101332] 'process raft request' (duration: 315.853392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:53:41.263336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T16:53:40.947095Z","time spent":"316.142385ms","remote":"127.0.0.1:54426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5469,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T16:53:56.79374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.096422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T16:53:56.793874Z","caller":"traceutil/trace.go:171","msg":"trace[107971454] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"212.195511ms","start":"2026-05-05T16:53:56.581644Z","end":"2026-05-05T16:53:56.79384Z","steps":["trace[107971454] 'process raft request' (duration: 41.815465ms)","trace[107971454] 'compare' (duration: 169.98238ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:54:45.307288Z","caller":"traceutil/trace.go:171","msg":"trace[582221436] transaction","detail":"{read_only:false; response_revision:1825; number_of_response:1; }","duration":"106.953355ms","start":"2026-05-05T16:54:45.200304Z","end":"2026-05-05T16:54:45.307257Z","steps":["trace[582221436] 'process raft request' (duration: 106.641338ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:54:45.491002Z","caller":"traceutil/trace.go:171","msg":"trace[266654844] linearizableReadLoop","detail":"{readStateIndex:1893; appliedIndex:1892; }","duration":"145.464096ms","start":"2026-05-05T16:54:45.345515Z","end":"2026-05-05T16:54:45.490979Z","steps":["trace[266654844] 'read index received' (duration: 145.251251ms)","trace[266654844] 'applied index is now lower than readState.Index' (duration: 211.975µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:54:45.491118Z","caller":"traceutil/trace.go:171","msg":"trace[627567885] transaction","detail":"{read_only:false; response_revision:1826; number_of_response:1; }","duration":"179.156671ms","start":"2026-05-05T16:54:45.311948Z","end":"2026-05-05T16:54:45.491105Z","steps":["trace[627567885] 'process raft request' (duration: 178.846934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:54:45.491417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.877156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T16:54:45.491542Z","caller":"traceutil/trace.go:171","msg":"trace[1846865884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1826; }","duration":"146.04637ms","start":"2026-05-05T16:54:45.345476Z","end":"2026-05-05T16:54:45.491522Z","steps":["trace[1846865884] 'agreement among raft nodes before linearized reading' (duration: 145.711842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:55:12.981389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.865314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T16:55:12.981718Z","caller":"traceutil/trace.go:171","msg":"trace[1483379679] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"141.434997ms","start":"2026-05-05T16:55:12.840261Z","end":"2026-05-05T16:55:12.981696Z","steps":["trace[1483379679] 'process raft request' (duration: 11.870515ms)","trace[1483379679] 'compare' (duration: 128.73958ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:55:13.096871Z","caller":"traceutil/trace.go:171","msg":"trace[1701941557] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"110.609367ms","start":"2026-05-05T16:55:12.986237Z","end":"2026-05-05T16:55:13.096847Z","steps":["trace[1701941557] 'process raft request' (duration: 99.334557ms)","trace[1701941557] 'compare' (duration: 11.177987ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:55:14.190053Z","caller":"traceutil/trace.go:171","msg":"trace[2057199817] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"173.822821ms","start":"2026-05-05T16:55:14.016193Z","end":"2026-05-05T16:55:14.190016Z","steps":["trace[2057199817] 'process raft request' (duration: 95.416752ms)","trace[2057199817] 'compare' (duration: 78.224934ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:55:14.738272Z","caller":"traceutil/trace.go:171","msg":"trace[1576878283] transaction","detail":"{read_only:false; response_revision:2032; number_of_response:1; }","duration":"113.70753ms","start":"2026-05-05T16:55:14.624533Z","end":"2026-05-05T16:55:14.738241Z","steps":["trace[1576878283] 'process raft request' (duration: 113.466143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:55:15.021139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.615128ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T16:55:15.02126Z","caller":"traceutil/trace.go:171","msg":"trace[985065367] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"272.42298ms","start":"2026-05-05T16:55:14.748817Z","end":"2026-05-05T16:55:15.02124Z","steps":["trace[985065367] 'process raft request' (duration: 116.280078ms)","trace[985065367] 'compare' (duration: 155.509785ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:55:15.190351Z","caller":"traceutil/trace.go:171","msg":"trace[748505375] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"101.187714ms","start":"2026-05-05T16:55:15.089121Z","end":"2026-05-05T16:55:15.190309Z","steps":["trace[748505375] 'process raft request' (duration: 100.934117ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:56:57.674976Z","caller":"traceutil/trace.go:171","msg":"trace[1909341337] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"144.835202ms","start":"2026-05-05T16:56:57.530114Z","end":"2026-05-05T16:56:57.674949Z","steps":["trace[1909341337] 'process raft request' (duration: 60.38774ms)","trace[1909341337] 'compare' (duration: 84.278477ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T16:56:57.967543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.899715ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T16:56:57.967927Z","caller":"traceutil/trace.go:171","msg":"trace[1563299525] linearizableReadLoop","detail":"{readStateIndex:2794; appliedIndex:2793; }","duration":"188.902793ms","start":"2026-05-05T16:56:57.779002Z","end":"2026-05-05T16:56:57.967904Z","steps":["trace[1563299525] 'read index received' (duration: 62.480983ms)","trace[1563299525] 'applied index is now lower than readState.Index' (duration: 126.41971ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:56:57.968282Z","caller":"traceutil/trace.go:171","msg":"trace[1844230515] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"232.46662ms","start":"2026-05-05T16:56:57.735788Z","end":"2026-05-05T16:56:57.968255Z","steps":["trace[1844230515] 'process raft request' (duration: 105.734181ms)","trace[1844230515] 'compare' (duration: 125.652136ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T16:56:57.968519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.501951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-05T16:56:57.968587Z","caller":"traceutil/trace.go:171","msg":"trace[2104079563] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2697; }","duration":"189.624495ms","start":"2026-05-05T16:56:57.778944Z","end":"2026-05-05T16:56:57.968569Z","steps":["trace[2104079563] 'agreement among raft nodes before linearized reading' (duration: 189.401388ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T16:59:07.470253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.321134ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T16:59:07.470381Z","caller":"traceutil/trace.go:171","msg":"trace[249348866] linearizableReadLoop","detail":"{readStateIndex:3597; appliedIndex:3596; }","duration":"168.275688ms","start":"2026-05-05T16:59:07.302085Z","end":"2026-05-05T16:59:07.470361Z","steps":["trace[249348866] 'read index received' (duration: 53.696698ms)","trace[249348866] 'applied index is now lower than readState.Index' (duration: 114.57782ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T16:59:07.470534Z","caller":"traceutil/trace.go:171","msg":"trace[1009696852] transaction","detail":"{read_only:false; response_revision:3469; number_of_response:1; }","duration":"170.67433ms","start":"2026-05-05T16:59:07.299835Z","end":"2026-05-05T16:59:07.470509Z","steps":["trace[1009696852] 'process raft request' (duration: 55.974506ms)","trace[1009696852] 'compare' (duration: 114.189901ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T16:59:07.470655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.600222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T16:59:07.470732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.622607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:1225"} {"level":"warn","ts":"2026-05-05T16:59:07.470669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.19359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:1225"} {"level":"info","ts":"2026-05-05T16:59:07.470733Z","caller":"traceutil/trace.go:171","msg":"trace[1991954973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3469; }","duration":"123.703285ms","start":"2026-05-05T16:59:07.347013Z","end":"2026-05-05T16:59:07.470716Z","steps":["trace[1991954973] 'agreement among raft nodes before linearized reading' (duration: 123.584312ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:59:07.470803Z","caller":"traceutil/trace.go:171","msg":"trace[1688367578] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:3469; }","duration":"168.70382ms","start":"2026-05-05T16:59:07.302081Z","end":"2026-05-05T16:59:07.470785Z","steps":["trace[1688367578] 'agreement among raft nodes before linearized reading' (duration: 168.509065ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T16:59:07.470817Z","caller":"traceutil/trace.go:171","msg":"trace[1452127400] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:3469; }","duration":"158.369304ms","start":"2026-05-05T16:59:07.312431Z","end":"2026-05-05T16:59:07.4708Z","steps":["trace[1452127400] 'agreement among raft nodes before linearized reading' (duration: 158.082747ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:00:45.199485Z","caller":"traceutil/trace.go:171","msg":"trace[1732087263] linearizableReadLoop","detail":"{readStateIndex:4825; appliedIndex:4824; }","duration":"114.893594ms","start":"2026-05-05T17:00:45.084571Z","end":"2026-05-05T17:00:45.199465Z","steps":["trace[1732087263] 'read index received' (duration: 114.672347ms)","trace[1732087263] 'applied index is now lower than readState.Index' (duration: 220.237µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T17:00:45.199533Z","caller":"traceutil/trace.go:171","msg":"trace[450659640] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"115.392617ms","start":"2026-05-05T17:00:45.084114Z","end":"2026-05-05T17:00:45.199507Z","steps":["trace[450659640] 'process raft request' (duration: 115.204982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:00:45.199756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.164191ms","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-05T17:00:45.19983Z","caller":"traceutil/trace.go:171","msg":"trace[753230446] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4653; }","duration":"115.273363ms","start":"2026-05-05T17:00:45.084539Z","end":"2026-05-05T17:00:45.199813Z","steps":["trace[753230446] 'agreement among raft nodes before linearized reading' (duration: 115.021546ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:00:45.99416Z","caller":"traceutil/trace.go:171","msg":"trace[135662132] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"167.178874ms","start":"2026-05-05T17:00:45.826959Z","end":"2026-05-05T17:00:45.994138Z","steps":["trace[135662132] 'process raft request' (duration: 167.028499ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:00:45.9983Z","caller":"traceutil/trace.go:171","msg":"trace[1657783205] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"157.020848ms","start":"2026-05-05T17:00:45.841266Z","end":"2026-05-05T17:00:45.998287Z","steps":["trace[1657783205] 'process raft request' (duration: 156.784872ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:00:47.404603Z","caller":"traceutil/trace.go:171","msg":"trace[2129201261] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"110.463502ms","start":"2026-05-05T17:00:47.294098Z","end":"2026-05-05T17:00:47.404561Z","steps":["trace[2129201261] 'process raft request' (duration: 103.890827ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:00:47.404745Z","caller":"traceutil/trace.go:171","msg":"trace[701917841] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"109.488494ms","start":"2026-05-05T17:00:47.295233Z","end":"2026-05-05T17:00:47.404722Z","steps":["trace[701917841] 'process raft request' (duration: 109.060882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:00:57.524411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.89677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:00:57.524474Z","caller":"traceutil/trace.go:171","msg":"trace[77690325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4822; }","duration":"177.997523ms","start":"2026-05-05T17:00:57.346463Z","end":"2026-05-05T17:00:57.524461Z","steps":["trace[77690325] 'range keys from in-memory index tree' (duration: 177.832158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:00:57.52454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.282177ms","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-05-05T17:00:57.524626Z","caller":"traceutil/trace.go:171","msg":"trace[294035364] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4822; }","duration":"276.39912ms","start":"2026-05-05T17:00:57.248209Z","end":"2026-05-05T17:00:57.524609Z","steps":["trace[294035364] 'range keys from in-memory index tree' (duration: 276.115342ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:02:31.141498Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2870} {"level":"info","ts":"2026-05-05T17:02:31.240623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2870,"took":"97.579644ms","hash":929936684,"current-db-size-bytes":53223424,"current-db-size":"53 MB","current-db-size-in-use-bytes":29323264,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-05T17:02:31.240688Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":929936684,"revision":2870,"compact-revision":-1} {"level":"info","ts":"2026-05-05T17:04:58.367636Z","caller":"traceutil/trace.go:171","msg":"trace[93508354] transaction","detail":"{read_only:false; response_revision:6588; number_of_response:1; }","duration":"100.246286ms","start":"2026-05-05T17:04:58.267366Z","end":"2026-05-05T17:04:58.367613Z","steps":["trace[93508354] 'process raft request' (duration: 99.888895ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:46.847002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952160968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:06:47.373326Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952160968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:06:47.874241Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952160968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:06:48.347334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000747285s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-05T17:06:48.347446Z","caller":"traceutil/trace.go:171","msg":"trace[1592606247] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00091172s","start":"2026-05-05T17:06:46.346509Z","end":"2026-05-05T17:06:48.347421Z","steps":["trace[1592606247] 'agreement among raft nodes before linearized reading' (duration: 2.000758496s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:48.347504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:46.346502Z","time spent":"2.000987382s","remote":"127.0.0.1:54272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:06:48.37532Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952160968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:06:48.875817Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952160968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:06:49.375743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000328365s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-05T17:06:49.375944Z","caller":"traceutil/trace.go:171","msg":"trace[314983589] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000564902s","start":"2026-05-05T17:06:47.375354Z","end":"2026-05-05T17:06:49.375919Z","steps":["trace[314983589] 'agreement among raft nodes before linearized reading' (duration: 2.000350486s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.376069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15132549915952160968,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T17:06:49.376226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:47.375342Z","time spent":"2.000864251s","remote":"127.0.0.1:54272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/05 17:06:49 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-05T17:06:49.865264Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.525829493s","expected-duration":"1s"} {"level":"info","ts":"2026-05-05T17:06:49.866437Z","caller":"traceutil/trace.go:171","msg":"trace[346186896] transaction","detail":"{read_only:false; response_revision:7159; number_of_response:1; }","duration":"3.526716499s","start":"2026-05-05T17:06:46.339362Z","end":"2026-05-05T17:06:49.866079Z","steps":["trace[346186896] 'process raft request' (duration: 3.526327058s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.866626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:46.339351Z","time spent":"3.527199594s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:06:49.867442Z","caller":"traceutil/trace.go:171","msg":"trace[1974718908] transaction","detail":"{read_only:false; response_revision:7161; number_of_response:1; }","duration":"2.491357541s","start":"2026-05-05T17:06:47.376068Z","end":"2026-05-05T17:06:49.867425Z","steps":["trace[1974718908] 'process raft request' (duration: 2.491028691s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.867525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:47.37606Z","time spent":"2.491411342s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:06:49.867757Z","caller":"traceutil/trace.go:171","msg":"trace[1912175879] transaction","detail":"{read_only:false; response_revision:7162; number_of_response:1; }","duration":"2.22103715s","start":"2026-05-05T17:06:47.646693Z","end":"2026-05-05T17:06:49.867731Z","steps":["trace[1912175879] 'process raft request' (duration: 2.220453643s)"],"step_count":1} {"level":"info","ts":"2026-05-05T17:06:49.867935Z","caller":"traceutil/trace.go:171","msg":"trace[1440434116] transaction","detail":"{read_only:false; response_revision:7160; number_of_response:1; }","duration":"2.491754413s","start":"2026-05-05T17:06:47.375496Z","end":"2026-05-05T17:06:49.86725Z","steps":["trace[1440434116] 'process raft request' (duration: 2.491513455s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.867847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:47.646665Z","time spent":"2.221139623s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T17:06:49.868209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:47.375485Z","time spent":"2.492582488s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T17:06:49.869614Z","caller":"traceutil/trace.go:171","msg":"trace[2070046321] linearizableReadLoop","detail":"{readStateIndex:7420; appliedIndex:7416; }","duration":"3.523071469s","start":"2026-05-05T17:06:46.34653Z","end":"2026-05-05T17:06:49.869602Z","steps":["trace[2070046321] 'read index received' (duration: 3.518982985s)","trace[2070046321] 'applied index is now lower than readState.Index' (duration: 4.087734ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T17:06:49.869957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.315444099s","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-05-05T17:06:49.86999Z","caller":"traceutil/trace.go:171","msg":"trace[538149710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7162; }","duration":"3.315508461s","start":"2026-05-05T17:06:46.554474Z","end":"2026-05-05T17:06:49.869982Z","steps":["trace[538149710] 'agreement among raft nodes before linearized reading' (duration: 3.315369257s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.870016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:46.554458Z","time spent":"3.315552162s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T17:06:49.870208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.212377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-05T17:06:49.870234Z","caller":"traceutil/trace.go:171","msg":"trace[1701988702] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:7162; }","duration":"525.266839ms","start":"2026-05-05T17:06:49.344961Z","end":"2026-05-05T17:06:49.870227Z","steps":["trace[1701988702] 'agreement among raft nodes before linearized reading' (duration: 525.195136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.870255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:49.344944Z","time spent":"525.3057ms","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-05-05T17:06:49.870389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.173023705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T17:06:49.870333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.016578278s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-05T17:06:49.870652Z","caller":"traceutil/trace.go:171","msg":"trace[1111277019] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7162; }","duration":"3.016937129s","start":"2026-05-05T17:06:46.853694Z","end":"2026-05-05T17:06:49.870631Z","steps":["trace[1111277019] 'agreement among raft nodes before linearized reading' (duration: 3.016473865s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.870721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:46.853675Z","time spent":"3.017030922s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-05T17:06:49.87042Z","caller":"traceutil/trace.go:171","msg":"trace[1436140919] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:7162; }","duration":"3.173058146s","start":"2026-05-05T17:06:46.697356Z","end":"2026-05-05T17:06:49.870414Z","steps":["trace[1436140919] 'agreement among raft nodes before linearized reading' (duration: 3.173007495s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.870952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.522712085s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T17:06:49.871001Z","caller":"traceutil/trace.go:171","msg":"trace[316680743] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7162; }","duration":"1.522788838s","start":"2026-05-05T17:06:48.348202Z","end":"2026-05-05T17:06:49.870991Z","steps":["trace[316680743] 'agreement among raft nodes before linearized reading' (duration: 1.522721166s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.871033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:48.348187Z","time spent":"1.52284045s","remote":"127.0.0.1:54262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T17:06:49.871158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:46.697304Z","time spent":"3.173654394s","remote":"127.0.0.1:54442","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":28,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-05-05T17:06:49.871246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.597040537s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-05-05T17:06:49.871281Z","caller":"traceutil/trace.go:171","msg":"trace[494464531] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:7162; }","duration":"1.597074938s","start":"2026-05-05T17:06:48.274197Z","end":"2026-05-05T17:06:49.871272Z","steps":["trace[494464531] 'agreement among raft nodes before linearized reading' (duration: 1.596971995s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.871314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:48.274144Z","time spent":"1.59716287s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":552,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-05-05T17:06:49.871357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.291135056s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-05T17:06:49.871428Z","caller":"traceutil/trace.go:171","msg":"trace[67993037] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7162; }","duration":"3.291260889s","start":"2026-05-05T17:06:46.58015Z","end":"2026-05-05T17:06:49.871411Z","steps":["trace[67993037] 'agreement among raft nodes before linearized reading' (duration: 3.291066853s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.871477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:46.580132Z","time spent":"3.291333382s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-05T17:06:49.871436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.464493392s","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-05T17:06:49.871573Z","caller":"traceutil/trace.go:171","msg":"trace[408640391] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7162; }","duration":"2.464655866s","start":"2026-05-05T17:06:47.40691Z","end":"2026-05-05T17:06:49.871566Z","steps":["trace[408640391] 'agreement among raft nodes before linearized reading' (duration: 2.4644686s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.871597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:47.406871Z","time spent":"2.464720499s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T17:06:49.871694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.645442738s","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-05-05T17:06:49.871716Z","caller":"traceutil/trace.go:171","msg":"trace[818129248] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7162; }","duration":"2.645500879s","start":"2026-05-05T17:06:47.226209Z","end":"2026-05-05T17:06:49.87171Z","steps":["trace[818129248] 'agreement among raft nodes before linearized reading' (duration: 2.645437827s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.871733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:47.226193Z","time spent":"2.64553604s","remote":"127.0.0.1:54508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T17:06:49.871739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.465208703s","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-05-05T17:06:49.871765Z","caller":"traceutil/trace.go:171","msg":"trace[1350859972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7162; }","duration":"2.465278515s","start":"2026-05-05T17:06:47.406479Z","end":"2026-05-05T17:06:49.871758Z","steps":["trace[1350859972] 'agreement among raft nodes before linearized reading' (duration: 2.464973176s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T17:06:49.871788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T17:06:47.40646Z","time spent":"2.465323726s","remote":"127.0.0.1:54508","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-05T17:07:31.154118Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5588} {"level":"info","ts":"2026-05-05T17:07:31.272816Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5588,"took":"117.505932ms","hash":3815707483,"current-db-size-bytes":53223424,"current-db-size":"53 MB","current-db-size-in-use-bytes":18051072,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-05T17:07:31.272871Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3815707483,"revision":5588,"compact-revision":2870}