{"level":"warn","ts":"2026-09-18T05:07:58.356561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T05:07:58.356779Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.143: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://162.253.55.143:2380","--initial-cluster=instance=https://162.253.55.143:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.143:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.143: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-09-18T05:07:58.356868Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T05:07:58.356882Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-18T05:07:58.356906Z","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-09-18T05:07:58.360827Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"]} {"level":"info","ts":"2026-09-18T05:07:58.361107Z","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://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.143: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-09-18T05:07:58.36852Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.964898ms"} {"level":"info","ts":"2026-09-18T05:07:58.379954Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7bf20b54406e85d1","cluster-id":"de54e01795e71fe2"} {"level":"info","ts":"2026-09-18T05:07:58.380077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T05:07:58.380108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 0"} {"level":"info","ts":"2026-09-18T05:07:58.380129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7bf20b54406e85d1 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T05:07:58.380156Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became follower at term 1"} {"level":"info","ts":"2026-09-18T05:07:58.380212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"warn","ts":"2026-09-18T05:07:58.387284Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T05:07:58.388846Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T05:07:58.390079Z","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-09-18T05:07:58.392731Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7bf20b54406e85d1","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T05:07:58.39344Z","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-09-18T05:07:58.393491Z","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-09-18T05:07:58.393598Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7bf20b54406e85d1","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T05:07:58.395277Z","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-09-18T05:07:58.396558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 switched to configuration voters=(8931213467515258321)"} {"level":"info","ts":"2026-09-18T05:07:58.397661Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","added-peer-id":"7bf20b54406e85d1","added-peer-peer-urls":["https://162.253.55.143:2380"]} {"level":"info","ts":"2026-09-18T05:07:58.400026Z","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-09-18T05:07:58.400219Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7bf20b54406e85d1","initial-advertise-peer-urls":["https://162.253.55.143:2380"],"listen-peer-urls":["https://162.253.55.143:2380"],"advertise-client-urls":["https://162.253.55.143:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.143:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T05:07:58.400248Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T05:07:58.400302Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-18T05:07:58.400315Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.143:2380"} {"level":"info","ts":"2026-09-18T05:07:58.581253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T05:07:58.58132Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T05:07:58.581337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgPreVoteResp from 7bf20b54406e85d1 at term 1"} {"level":"info","ts":"2026-09-18T05:07:58.581356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became candidate at term 2"} {"level":"info","ts":"2026-09-18T05:07:58.581364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 received MsgVoteResp from 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-18T05:07:58.581378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7bf20b54406e85d1 became leader at term 2"} {"level":"info","ts":"2026-09-18T05:07:58.581387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7bf20b54406e85d1 elected leader 7bf20b54406e85d1 at term 2"} {"level":"info","ts":"2026-09-18T05:07:58.582182Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:07:58.5829Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7bf20b54406e85d1","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.143:2379]}","request-path":"/0/members/7bf20b54406e85d1/attributes","cluster-id":"de54e01795e71fe2","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T05:07:58.583033Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:07:58.583083Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T05:07:58.585534Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T05:07:58.585683Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.143:2379"} {"level":"info","ts":"2026-09-18T05:07:58.585709Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"de54e01795e71fe2","local-member-id":"7bf20b54406e85d1","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:07:58.585821Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:07:58.585855Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T05:07:58.585883Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T05:07:58.585897Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T05:08:42.27381Z","caller":"traceutil/trace.go:171","msg":"trace[389748401] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"139.76003ms","start":"2026-09-18T05:08:42.134017Z","end":"2026-09-18T05:08:42.273777Z","steps":["trace[389748401] 'read index received' (duration: 131.570768ms)","trace[389748401] 'applied index is now lower than readState.Index' (duration: 8.188722ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:08:42.273918Z","caller":"traceutil/trace.go:171","msg":"trace[723585808] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"142.943156ms","start":"2026-09-18T05:08:42.130956Z","end":"2026-09-18T05:08:42.273899Z","steps":["trace[723585808] 'process raft request' (duration: 134.439432ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:42.274084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.048592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-09-18T05:08:42.274198Z","caller":"traceutil/trace.go:171","msg":"trace[1187232079] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:632; }","duration":"140.209058ms","start":"2026-09-18T05:08:42.133973Z","end":"2026-09-18T05:08:42.274182Z","steps":["trace[1187232079] 'agreement among raft nodes before linearized reading' (duration: 139.915056ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:42.27443Z","caller":"traceutil/trace.go:171","msg":"trace[1578428541] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"102.519136ms","start":"2026-09-18T05:08:42.171866Z","end":"2026-09-18T05:08:42.274386Z","steps":["trace[1578428541] 'process raft request' (duration: 102.145992ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:42.53524Z","caller":"traceutil/trace.go:171","msg":"trace[1104502172] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"105.988823ms","start":"2026-09-18T05:08:42.429223Z","end":"2026-09-18T05:08:42.535211Z","steps":["trace[1104502172] 'read index received' (duration: 105.935701ms)","trace[1104502172] 'applied index is now lower than readState.Index' (duration: 51.752µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:08:42.535844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.602378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-09-18T05:08:42.535901Z","caller":"traceutil/trace.go:171","msg":"trace[507876422] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:636; }","duration":"106.697313ms","start":"2026-09-18T05:08:42.429188Z","end":"2026-09-18T05:08:42.535886Z","steps":["trace[507876422] 'agreement among raft nodes before linearized reading' (duration: 106.128979ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:42.545776Z","caller":"traceutil/trace.go:171","msg":"trace[1982878321] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"114.618493ms","start":"2026-09-18T05:08:42.431116Z","end":"2026-09-18T05:08:42.545735Z","steps":["trace[1982878321] 'process raft request' (duration: 113.979148ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:08:49.360377Z","caller":"traceutil/trace.go:171","msg":"trace[2127132491] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"233.128158ms","start":"2026-09-18T05:08:49.127221Z","end":"2026-09-18T05:08:49.360349Z","steps":["trace[2127132491] 'process raft request' (duration: 202.439819ms)","trace[2127132491] 'compare' (duration: 30.553144ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:08:49.987894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.311172ms","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-09-18T05:08:49.988292Z","caller":"traceutil/trace.go:171","msg":"trace[2078968590] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:701; }","duration":"527.714376ms","start":"2026-09-18T05:08:49.460518Z","end":"2026-09-18T05:08:49.988232Z","steps":["trace[2078968590] 'range keys from in-memory index tree' (duration: 527.147686ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:49.988461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:08:49.460498Z","time spent":"527.944125ms","remote":"127.0.0.1:44710","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-09-18T05:08:49.987894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.517048ms","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-09-18T05:08:49.988948Z","caller":"traceutil/trace.go:171","msg":"trace[1647065565] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:701; }","duration":"157.592957ms","start":"2026-09-18T05:08:49.831322Z","end":"2026-09-18T05:08:49.988915Z","steps":["trace[1647065565] 'range keys from in-memory index tree' (duration: 156.369552ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:08:49.989146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.633584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:08:49.98926Z","caller":"traceutil/trace.go:171","msg":"trace[1405289637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:701; }","duration":"153.768888ms","start":"2026-09-18T05:08:49.835475Z","end":"2026-09-18T05:08:49.989244Z","steps":["trace[1405289637] 'range keys from in-memory index tree' (duration: 151.950983ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:06.763511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.17247ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T05:09:06.763834Z","caller":"traceutil/trace.go:171","msg":"trace[2014196660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:820; }","duration":"321.501681ms","start":"2026-09-18T05:09:06.442304Z","end":"2026-09-18T05:09:06.763805Z","steps":["trace[2014196660] 'range keys from in-memory index tree' (duration: 321.008416ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:06.763962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:06.442297Z","time spent":"321.645435ms","remote":"127.0.0.1:44710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T05:09:06.763509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.793461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:09:06.764121Z","caller":"traceutil/trace.go:171","msg":"trace[1357415439] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:820; }","duration":"374.440789ms","start":"2026-09-18T05:09:06.389632Z","end":"2026-09-18T05:09:06.764073Z","steps":["trace[1357415439] 'count revisions from in-memory index tree' (duration: 373.708868ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:06.763677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.049533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-09-18T05:09:06.764223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:06.389612Z","time spent":"374.576994ms","remote":"127.0.0.1:44526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":93,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-09-18T05:09:06.764258Z","caller":"traceutil/trace.go:171","msg":"trace[510633618] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:820; }","duration":"107.738783ms","start":"2026-09-18T05:09:06.656496Z","end":"2026-09-18T05:09:06.764235Z","steps":["trace[510633618] 'count revisions from in-memory index tree' (duration: 106.9412ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:06.763629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.049056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:09:06.764566Z","caller":"traceutil/trace.go:171","msg":"trace[2122999967] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:820; }","duration":"327.124538ms","start":"2026-09-18T05:09:06.437429Z","end":"2026-09-18T05:09:06.764554Z","steps":["trace[2122999967] 'count revisions from in-memory index tree' (duration: 325.959343ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:06.764645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:09:06.437411Z","time spent":"327.2001ms","remote":"127.0.0.1:44750","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-09-18T05:09:36.132181Z","caller":"traceutil/trace.go:171","msg":"trace[823199020] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"178.468701ms","start":"2026-09-18T05:09:35.953681Z","end":"2026-09-18T05:09:36.13215Z","steps":["trace[823199020] 'process raft request' (duration: 178.253285ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:50.683072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.424821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:09:50.683219Z","caller":"traceutil/trace.go:171","msg":"trace[504308159] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"181.502057ms","start":"2026-09-18T05:09:50.501694Z","end":"2026-09-18T05:09:50.683196Z","steps":["trace[504308159] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/serviceaccounts/ingress-nginx/default; req_size:165; } (duration: 171.183555ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:50.684442Z","caller":"traceutil/trace.go:171","msg":"trace[1668082874] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"182.357573ms","start":"2026-09-18T05:09:50.502046Z","end":"2026-09-18T05:09:50.684404Z","steps":["trace[1668082874] 'process raft request' (duration: 182.315322ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:50.684754Z","caller":"traceutil/trace.go:171","msg":"trace[1652768604] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"182.867073ms","start":"2026-09-18T05:09:50.501861Z","end":"2026-09-18T05:09:50.684728Z","steps":["trace[1652768604] 'process raft request' (duration: 182.355494ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:50.69564Z","caller":"traceutil/trace.go:171","msg":"trace[1703788234] transaction","detail":"{read_only:false; response_revision:1327; number_of_response:1; }","duration":"116.997936ms","start":"2026-09-18T05:09:50.578624Z","end":"2026-09-18T05:09:50.695622Z","steps":["trace[1703788234] 'process raft request' (duration: 116.942845ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:50.695649Z","caller":"traceutil/trace.go:171","msg":"trace[2016256202] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"158.862783ms","start":"2026-09-18T05:09:50.536765Z","end":"2026-09-18T05:09:50.695628Z","steps":["trace[2016256202] 'process raft request' (duration: 158.626159ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:09:57.693837Z","caller":"traceutil/trace.go:171","msg":"trace[195871680] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1395; }","duration":"104.672343ms","start":"2026-09-18T05:09:57.58914Z","end":"2026-09-18T05:09:57.693812Z","steps":["trace[195871680] 'process raft request' (duration: 104.51595ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:09:59.522687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.269544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T05:09:59.522777Z","caller":"traceutil/trace.go:171","msg":"trace[296215249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1473; }","duration":"220.452027ms","start":"2026-09-18T05:09:59.302304Z","end":"2026-09-18T05:09:59.522756Z","steps":["trace[296215249] 'range keys from in-memory index tree' (duration: 220.013789ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:10:29.372544Z","caller":"traceutil/trace.go:171","msg":"trace[1900144983] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"270.080862ms","start":"2026-09-18T05:10:29.102436Z","end":"2026-09-18T05:10:29.372516Z","steps":["trace[1900144983] 'read index received' (duration: 269.96042ms)","trace[1900144983] 'applied index is now lower than readState.Index' (duration: 119.312µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:10:29.37268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.195853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:10:29.372756Z","caller":"traceutil/trace.go:171","msg":"trace[685376584] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1918; }","duration":"270.353666ms","start":"2026-09-18T05:10:29.102387Z","end":"2026-09-18T05:10:29.37274Z","steps":["trace[685376584] 'agreement among raft nodes before linearized reading' (duration: 270.175873ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:10:29.372861Z","caller":"traceutil/trace.go:171","msg":"trace[1504544187] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"344.568165ms","start":"2026-09-18T05:10:29.028114Z","end":"2026-09-18T05:10:29.372682Z","steps":["trace[1504544187] 'process raft request' (duration: 344.21398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:10:29.3731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.752112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-18T05:10:29.373181Z","caller":"traceutil/trace.go:171","msg":"trace[1167901274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1918; }","duration":"106.969785ms","start":"2026-09-18T05:10:29.266194Z","end":"2026-09-18T05:10:29.373164Z","steps":["trace[1167901274] 'agreement among raft nodes before linearized reading' (duration: 106.567819ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:10:29.37369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:10:29.028061Z","time spent":"345.081763ms","remote":"127.0.0.1:44710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:10:29.851191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.151603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T05:10:29.851363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.576218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T05:10:29.851408Z","caller":"traceutil/trace.go:171","msg":"trace[1425045606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1919; }","duration":"114.660469ms","start":"2026-09-18T05:10:29.736735Z","end":"2026-09-18T05:10:29.851396Z","steps":["trace[1425045606] 'range keys from in-memory index tree' (duration: 114.402945ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:10:29.851398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.580545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-09-18T05:10:29.851417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.098745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ade114d8-7c6e-4bd2-a43a-35497ca251e9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-09-18T05:10:29.851451Z","caller":"traceutil/trace.go:171","msg":"trace[612121218] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ade114d8-7c6e-4bd2-a43a-35497ca251e9; range_end:; response_count:1; response_revision:1919; }","duration":"233.173085ms","start":"2026-09-18T05:10:29.61827Z","end":"2026-09-18T05:10:29.851443Z","steps":["trace[612121218] 'range keys from in-memory index tree' (duration: 232.985193ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:10:29.851455Z","caller":"traceutil/trace.go:171","msg":"trace[690949346] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1919; }","duration":"269.676066ms","start":"2026-09-18T05:10:29.581763Z","end":"2026-09-18T05:10:29.851439Z","steps":["trace[690949346] 'range keys from in-memory index tree' (duration: 269.411792ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:10:29.851497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.776688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-18T05:10:29.851321Z","caller":"traceutil/trace.go:171","msg":"trace[1155477133] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1919; }","duration":"243.322105ms","start":"2026-09-18T05:10:29.607972Z","end":"2026-09-18T05:10:29.851294Z","steps":["trace[1155477133] 'count revisions from in-memory index tree' (duration: 243.072362ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:10:29.851562Z","caller":"traceutil/trace.go:171","msg":"trace[1271644731] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1919; }","duration":"107.887999ms","start":"2026-09-18T05:10:29.743657Z","end":"2026-09-18T05:10:29.851545Z","steps":["trace[1271644731] 'range keys from in-memory index tree' (duration: 107.643286ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:10:42.547348Z","caller":"traceutil/trace.go:171","msg":"trace[1776893552] linearizableReadLoop","detail":"{readStateIndex:2100; appliedIndex:2099; }","duration":"126.26761ms","start":"2026-09-18T05:10:42.421058Z","end":"2026-09-18T05:10:42.547326Z","steps":["trace[1776893552] 'read index received' (duration: 126.24557ms)","trace[1776893552] 'applied index is now lower than readState.Index' (duration: 21.03µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:10:42.547413Z","caller":"traceutil/trace.go:171","msg":"trace[776752812] transaction","detail":"{read_only:false; response_revision:2021; number_of_response:1; }","duration":"386.831752ms","start":"2026-09-18T05:10:42.160564Z","end":"2026-09-18T05:10:42.547396Z","steps":["trace[776752812] 'process raft request' (duration: 386.640179ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:10:42.547519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:10:42.160536Z","time spent":"386.910693ms","remote":"127.0.0.1:44710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T05:10:42.547516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.480933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.143\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-09-18T05:10:42.547571Z","caller":"traceutil/trace.go:171","msg":"trace[1758126855] range","detail":"{range_begin:/registry/masterleases/162.253.55.143; range_end:; response_count:1; response_revision:2021; }","duration":"126.585444ms","start":"2026-09-18T05:10:42.42096Z","end":"2026-09-18T05:10:42.547546Z","steps":["trace[1758126855] 'agreement among raft nodes before linearized reading' (duration: 126.445692ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:11:04.475022Z","caller":"traceutil/trace.go:171","msg":"trace[237428370] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"209.191915ms","start":"2026-09-18T05:11:04.265798Z","end":"2026-09-18T05:11:04.47499Z","steps":["trace[237428370] 'process raft request' (duration: 147.74894ms)","trace[237428370] 'compare' (duration: 61.060821ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:11:04.880688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.542395ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:11:04.880842Z","caller":"traceutil/trace.go:171","msg":"trace[842970618] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2161; }","duration":"236.704077ms","start":"2026-09-18T05:11:04.64411Z","end":"2026-09-18T05:11:04.880814Z","steps":["trace[842970618] 'range keys from in-memory index tree' (duration: 236.525915ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:11:04.881542Z","caller":"traceutil/trace.go:171","msg":"trace[2106032406] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"251.614654ms","start":"2026-09-18T05:11:04.629879Z","end":"2026-09-18T05:11:04.881493Z","steps":["trace[2106032406] 'process raft request' (duration: 200.583578ms)","trace[2106032406] 'compare' (duration: 50.039864ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:11:04.930139Z","caller":"traceutil/trace.go:171","msg":"trace[194519187] linearizableReadLoop","detail":"{readStateIndex:2248; appliedIndex:2245; }","duration":"113.150249ms","start":"2026-09-18T05:11:04.816959Z","end":"2026-09-18T05:11:04.93011Z","steps":["trace[194519187] 'read index received' (duration: 13.513218ms)","trace[194519187] 'applied index is now lower than readState.Index' (duration: 99.635911ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:11:04.930177Z","caller":"traceutil/trace.go:171","msg":"trace[1662435867] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"266.054824ms","start":"2026-09-18T05:11:04.664094Z","end":"2026-09-18T05:11:04.930149Z","steps":["trace[1662435867] 'process raft request' (duration: 265.667909ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:11:04.930207Z","caller":"traceutil/trace.go:171","msg":"trace[626808961] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"201.406048ms","start":"2026-09-18T05:11:04.728779Z","end":"2026-09-18T05:11:04.930185Z","steps":["trace[626808961] 'process raft request' (duration: 201.248326ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:11:04.930375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.393972ms","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-09-18T05:11:04.930448Z","caller":"traceutil/trace.go:171","msg":"trace[1870675122] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2164; }","duration":"113.543354ms","start":"2026-09-18T05:11:04.816886Z","end":"2026-09-18T05:11:04.93043Z","steps":["trace[1870675122] 'agreement among raft nodes before linearized reading' (duration: 113.331792ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:11:05.282454Z","caller":"traceutil/trace.go:171","msg":"trace[7832322] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2249; }","duration":"114.602731ms","start":"2026-09-18T05:11:05.167821Z","end":"2026-09-18T05:11:05.282424Z","steps":["trace[7832322] 'read index received' (duration: 73.105256ms)","trace[7832322] 'applied index is now lower than readState.Index' (duration: 41.496155ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:11:05.282551Z","caller":"traceutil/trace.go:171","msg":"trace[1218244080] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"226.814533ms","start":"2026-09-18T05:11:05.055701Z","end":"2026-09-18T05:11:05.282516Z","steps":["trace[1218244080] 'process raft request' (duration: 185.239337ms)","trace[1218244080] 'compare' (duration: 41.15389ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:11:05.282725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.895146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-18T05:11:05.282806Z","caller":"traceutil/trace.go:171","msg":"trace[1477931053] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2166; }","duration":"115.036797ms","start":"2026-09-18T05:11:05.167745Z","end":"2026-09-18T05:11:05.282782Z","steps":["trace[1477931053] 'agreement among raft nodes before linearized reading' (duration: 114.793484ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:11:05.924276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.119728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-09-18T05:11:05.92438Z","caller":"traceutil/trace.go:171","msg":"trace[147150752] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2167; }","duration":"140.26762ms","start":"2026-09-18T05:11:05.784089Z","end":"2026-09-18T05:11:05.924357Z","steps":["trace[147150752] 'range keys from in-memory index tree' (duration: 139.966937ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:11:05.924849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.582009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T05:11:05.924973Z","caller":"traceutil/trace.go:171","msg":"trace[861824998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2167; }","duration":"117.766811ms","start":"2026-09-18T05:11:05.807181Z","end":"2026-09-18T05:11:05.924948Z","steps":["trace[861824998] 'range keys from in-memory index tree' (duration: 117.390746ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:11:06.130747Z","caller":"traceutil/trace.go:171","msg":"trace[768667501] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"201.083027ms","start":"2026-09-18T05:11:05.92964Z","end":"2026-09-18T05:11:06.130723Z","steps":["trace[768667501] 'process raft request' (duration: 200.52366ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:12:53.801561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.644826ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T05:12:53.802164Z","caller":"traceutil/trace.go:171","msg":"trace[168801420] transaction","detail":"{read_only:false; response_revision:2851; number_of_response:1; }","duration":"108.883199ms","start":"2026-09-18T05:12:53.693262Z","end":"2026-09-18T05:12:53.802145Z","steps":["trace[168801420] 'process raft request' (duration: 108.820826ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:12:53.802487Z","caller":"traceutil/trace.go:171","msg":"trace[274966466] transaction","detail":"{read_only:false; response_revision:2849; number_of_response:1; }","duration":"472.346639ms","start":"2026-09-18T05:12:53.330126Z","end":"2026-09-18T05:12:53.802473Z","steps":["trace[274966466] 'process raft request' (duration: 176.711761ms)","trace[274966466] 'compare' (duration: 294.445488ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:12:53.802566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:12:53.330096Z","time spent":"472.430693ms","remote":"127.0.0.1:44710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T05:12:53.803288Z","caller":"traceutil/trace.go:171","msg":"trace[1746117180] linearizableReadLoop","detail":"{readStateIndex:2959; appliedIndex:2957; }","duration":"430.666195ms","start":"2026-09-18T05:12:53.372579Z","end":"2026-09-18T05:12:53.803245Z","steps":["trace[1746117180] 'read index received' (duration: 134.413971ms)","trace[1746117180] 'applied index is now lower than readState.Index' (duration: 296.248834ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:12:53.803378Z","caller":"traceutil/trace.go:171","msg":"trace[1826315253] transaction","detail":"{read_only:false; response_revision:2850; number_of_response:1; }","duration":"469.461188ms","start":"2026-09-18T05:12:53.333853Z","end":"2026-09-18T05:12:53.803315Z","steps":["trace[1826315253] 'process raft request' (duration: 467.80124ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:12:53.803559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:12:53.333824Z","time spent":"469.642955ms","remote":"127.0.0.1:44710","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-09-18T05:12:53.803664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.012559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:12:53.80378Z","caller":"traceutil/trace.go:171","msg":"trace[72547070] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2851; }","duration":"431.178446ms","start":"2026-09-18T05:12:53.372572Z","end":"2026-09-18T05:12:53.80375Z","steps":["trace[72547070] 'agreement among raft nodes before linearized reading' (duration: 430.943046ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:12:53.803837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T05:12:53.372505Z","time spent":"431.319492ms","remote":"127.0.0.1:36794","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-09-18T05:12:53.804271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.633441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-18T05:12:53.804328Z","caller":"traceutil/trace.go:171","msg":"trace[1050046828] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2851; }","duration":"254.758527ms","start":"2026-09-18T05:12:53.549555Z","end":"2026-09-18T05:12:53.804314Z","steps":["trace[1050046828] 'agreement among raft nodes before linearized reading' (duration: 254.570039ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:12:58.83089Z","caller":"traceutil/trace.go:171","msg":"trace[2013112469] transaction","detail":"{read_only:false; response_revision:2876; number_of_response:1; }","duration":"105.12563ms","start":"2026-09-18T05:12:58.725725Z","end":"2026-09-18T05:12:58.83085Z","steps":["trace[2013112469] 'process raft request' (duration: 104.762225ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:16:44.210815Z","caller":"traceutil/trace.go:171","msg":"trace[497747029] linearizableReadLoop","detail":"{readStateIndex:4383; appliedIndex:4381; }","duration":"105.33179ms","start":"2026-09-18T05:16:44.105445Z","end":"2026-09-18T05:16:44.210777Z","steps":["trace[497747029] 'read index received' (duration: 55.9743ms)","trace[497747029] 'applied index is now lower than readState.Index' (duration: 49.35566ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:16:44.211138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.664116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-18T05:16:44.211226Z","caller":"traceutil/trace.go:171","msg":"trace[413046140] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4218; }","duration":"105.783438ms","start":"2026-09-18T05:16:44.105426Z","end":"2026-09-18T05:16:44.21121Z","steps":["trace[413046140] 'agreement among raft nodes before linearized reading' (duration: 105.519353ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:16:44.211116Z","caller":"traceutil/trace.go:171","msg":"trace[154523915] transaction","detail":"{read_only:false; response_revision:4218; number_of_response:1; }","duration":"108.032408ms","start":"2026-09-18T05:16:44.102979Z","end":"2026-09-18T05:16:44.211012Z","steps":["trace[154523915] 'process raft request' (duration: 102.866095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:16:44.214674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.121088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-18T05:16:44.214752Z","caller":"traceutil/trace.go:171","msg":"trace[350057143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4219; }","duration":"109.218019ms","start":"2026-09-18T05:16:44.105516Z","end":"2026-09-18T05:16:44.214734Z","steps":["trace[350057143] 'agreement among raft nodes before linearized reading' (duration: 109.009136ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:22.630006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.213443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1825"} {"level":"info","ts":"2026-09-18T05:17:22.630129Z","caller":"traceutil/trace.go:171","msg":"trace[681506468] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4882; }","duration":"111.384596ms","start":"2026-09-18T05:17:22.518726Z","end":"2026-09-18T05:17:22.63011Z","steps":["trace[681506468] 'agreement among raft nodes before linearized reading' (duration: 111.099981ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:23.04156Z","caller":"traceutil/trace.go:171","msg":"trace[935695527] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"140.251602ms","start":"2026-09-18T05:17:22.901267Z","end":"2026-09-18T05:17:23.041519Z","steps":["trace[935695527] 'process raft request' (duration: 83.937434ms)","trace[935695527] 'compare' (duration: 55.883771ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:17:23.041731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.316489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:17:23.041773Z","caller":"traceutil/trace.go:171","msg":"trace[10320107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4890; }","duration":"119.39633ms","start":"2026-09-18T05:17:22.922368Z","end":"2026-09-18T05:17:23.041764Z","steps":["trace[10320107] 'agreement among raft nodes before linearized reading' (duration: 119.322669ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:23.041647Z","caller":"traceutil/trace.go:171","msg":"trace[473619273] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"119.118806ms","start":"2026-09-18T05:17:22.922514Z","end":"2026-09-18T05:17:23.041633Z","steps":["trace[473619273] 'process raft request' (duration: 118.981533ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:23.041869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.461491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-97cabf6e-4b4f-4631-a89a-144c3f8c8624\" ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-09-18T05:17:23.041913Z","caller":"traceutil/trace.go:171","msg":"trace[1175883340] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-97cabf6e-4b4f-4631-a89a-144c3f8c8624; range_end:; response_count:1; response_revision:4890; }","duration":"119.534802ms","start":"2026-09-18T05:17:22.922367Z","end":"2026-09-18T05:17:23.041902Z","steps":["trace[1175883340] 'agreement among raft nodes before linearized reading' (duration: 119.361179ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:23.041638Z","caller":"traceutil/trace.go:171","msg":"trace[1030178055] linearizableReadLoop","detail":"{readStateIndex:5077; appliedIndex:5076; }","duration":"119.215286ms","start":"2026-09-18T05:17:22.922399Z","end":"2026-09-18T05:17:23.041614Z","steps":["trace[1030178055] 'read index received' (duration: 62.814657ms)","trace[1030178055] 'applied index is now lower than readState.Index' (duration: 56.397509ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T05:17:23.042132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.492227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-18T05:17:23.042166Z","caller":"traceutil/trace.go:171","msg":"trace[1239572437] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:4890; }","duration":"105.538597ms","start":"2026-09-18T05:17:22.93662Z","end":"2026-09-18T05:17:23.042159Z","steps":["trace[1239572437] 'agreement among raft nodes before linearized reading' (duration: 105.470316ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:23.042742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.366551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-18T05:17:23.042778Z","caller":"traceutil/trace.go:171","msg":"trace[1197485216] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4890; }","duration":"106.426002ms","start":"2026-09-18T05:17:22.936344Z","end":"2026-09-18T05:17:23.04277Z","steps":["trace[1197485216] 'agreement among raft nodes before linearized reading' (duration: 105.700289ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:32.072303Z","caller":"traceutil/trace.go:171","msg":"trace[703813510] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"107.982833ms","start":"2026-09-18T05:17:31.964295Z","end":"2026-09-18T05:17:32.072278Z","steps":["trace[703813510] 'process raft request' (duration: 107.862581ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:32.913379Z","caller":"traceutil/trace.go:171","msg":"trace[1111084127] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"142.640517ms","start":"2026-09-18T05:17:32.77071Z","end":"2026-09-18T05:17:32.913351Z","steps":["trace[1111084127] 'process raft request' (duration: 108.424069ms)","trace[1111084127] 'compare' (duration: 34.061475ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:17:33.122087Z","caller":"traceutil/trace.go:171","msg":"trace[1522903745] linearizableReadLoop","detail":"{readStateIndex:5228; appliedIndex:5226; }","duration":"166.789844ms","start":"2026-09-18T05:17:32.955276Z","end":"2026-09-18T05:17:33.122066Z","steps":["trace[1522903745] 'read index received' (duration: 164.434335ms)","trace[1522903745] 'applied index is now lower than readState.Index' (duration: 2.353879ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T05:17:33.122126Z","caller":"traceutil/trace.go:171","msg":"trace[164802412] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"202.048209ms","start":"2026-09-18T05:17:32.920065Z","end":"2026-09-18T05:17:33.122114Z","steps":["trace[164802412] 'process raft request' (duration: 199.676569ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:33.122119Z","caller":"traceutil/trace.go:171","msg":"trace[1926209699] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"189.999959ms","start":"2026-09-18T05:17:32.932084Z","end":"2026-09-18T05:17:33.122084Z","steps":["trace[1926209699] 'process raft request' (duration: 189.828426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:33.122183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.533896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T05:17:33.122212Z","caller":"traceutil/trace.go:171","msg":"trace[1437545575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5036; }","duration":"199.603467ms","start":"2026-09-18T05:17:32.922601Z","end":"2026-09-18T05:17:33.122204Z","steps":["trace[1437545575] 'agreement among raft nodes before linearized reading' (duration: 199.542386ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:33.122234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.136064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1652"} {"level":"info","ts":"2026-09-18T05:17:33.122286Z","caller":"traceutil/trace.go:171","msg":"trace[651883052] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5036; }","duration":"198.218105ms","start":"2026-09-18T05:17:32.924056Z","end":"2026-09-18T05:17:33.122274Z","steps":["trace[651883052] 'agreement among raft nodes before linearized reading' (duration: 198.053102ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T05:17:35.932167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.959222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-09-18T05:17:35.932249Z","caller":"traceutil/trace.go:171","msg":"trace[253233299] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5135; }","duration":"223.095855ms","start":"2026-09-18T05:17:35.709135Z","end":"2026-09-18T05:17:35.93223Z","steps":["trace[253233299] 'range keys from in-memory index tree' (duration: 222.79068ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:46.103128Z","caller":"traceutil/trace.go:171","msg":"trace[1890383789] transaction","detail":"{read_only:false; response_revision:5275; number_of_response:1; }","duration":"113.914883ms","start":"2026-09-18T05:17:45.989154Z","end":"2026-09-18T05:17:46.103068Z","steps":["trace[1890383789] 'process raft request' (duration: 113.73399ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:17:59.215513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2881} {"level":"info","ts":"2026-09-18T05:17:59.296886Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2881,"took":"80.412355ms","hash":2772426527,"current-db-size-bytes":51875840,"current-db-size":"52 MB","current-db-size-in-use-bytes":27648000,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-18T05:17:59.296933Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2772426527,"revision":2881,"compact-revision":-1} {"level":"info","ts":"2026-09-18T05:21:53.538883Z","caller":"traceutil/trace.go:171","msg":"trace[1404135723] transaction","detail":"{read_only:false; response_revision:7051; number_of_response:1; }","duration":"129.565699ms","start":"2026-09-18T05:21:53.409301Z","end":"2026-09-18T05:21:53.538866Z","steps":["trace[1404135723] 'process raft request' (duration: 129.466116ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T05:22:59.221651Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5358} {"level":"info","ts":"2026-09-18T05:22:59.347169Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5358,"took":"123.59347ms","hash":2582956925,"current-db-size-bytes":51875840,"current-db-size":"52 MB","current-db-size-in-use-bytes":19079168,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-18T05:22:59.347279Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2582956925,"revision":5358,"compact-revision":2881}