{"level":"warn","ts":"2026-04-27T12:01:25.233832Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T12:01:25.233938Z","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-04-27T12:01:25.234262Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T12:01:25.234283Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.141:2380"]} {"level":"info","ts":"2026-04-27T12:01:25.234323Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T12:01:25.235172Z","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-04-27T12:01:25.235275Z","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-04-27T12:01:25.24207Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.643159ms"} {"level":"info","ts":"2026-04-27T12:01:25.248817Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe263d225de0d201","cluster-id":"24f15cf84c3a7bc3"} {"level":"info","ts":"2026-04-27T12:01:25.248899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T12:01:25.248923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became follower at term 0"} {"level":"info","ts":"2026-04-27T12:01:25.248938Z","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-04-27T12:01:25.248955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became follower at term 1"} {"level":"info","ts":"2026-04-27T12:01:25.249001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=(18313392152561897985)"} {"level":"warn","ts":"2026-04-27T12:01:25.254549Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T12:01:25.25648Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T12:01:25.257403Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T12:01:25.260682Z","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-04-27T12:01:25.260973Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T12:01:25.261128Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T12:01:25.261166Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T12:01:25.26103Z","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-04-27T12:01:25.263105Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 switched to configuration voters=(18313392152561897985)"} {"level":"info","ts":"2026-04-27T12:01:25.263914Z","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-04-27T12:01:25.26698Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T12:01:25.267157Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.141:2380"} {"level":"info","ts":"2026-04-27T12:01:25.267223Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.141:2380"} {"level":"info","ts":"2026-04-27T12:01:25.267363Z","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-04-27T12:01:25.267429Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T12:01:25.949764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T12:01:25.949844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T12:01:25.949885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 received MsgPreVoteResp from fe263d225de0d201 at term 1"} {"level":"info","ts":"2026-04-27T12:01:25.949903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became candidate at term 2"} {"level":"info","ts":"2026-04-27T12:01:25.949913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 received MsgVoteResp from fe263d225de0d201 at term 2"} {"level":"info","ts":"2026-04-27T12:01:25.949926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe263d225de0d201 became leader at term 2"} {"level":"info","ts":"2026-04-27T12:01:25.949938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe263d225de0d201 elected leader fe263d225de0d201 at term 2"} {"level":"info","ts":"2026-04-27T12:01:25.9511Z","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-04-27T12:01:25.95128Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T12:01:25.951461Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T12:01:25.951747Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T12:01:25.95228Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T12:01:25.952318Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T12:01:25.954045Z","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-04-27T12:01:25.954244Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T12:01:25.954298Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T12:01:25.956491Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.141:2379"} {"level":"info","ts":"2026-04-27T12:01:25.956897Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T12:01:56.152083Z","caller":"traceutil/trace.go:171","msg":"trace[565915706] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"173.377453ms","start":"2026-04-27T12:01:55.978676Z","end":"2026-04-27T12:01:56.152054Z","steps":["trace[565915706] 'process raft request' (duration: 173.227523ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:01:56.639777Z","caller":"traceutil/trace.go:171","msg":"trace[1056158128] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"319.557225ms","start":"2026-04-27T12:01:56.3202Z","end":"2026-04-27T12:01:56.639758Z","steps":["trace[1056158128] 'process raft request' (duration: 319.379234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:01:56.640116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:01:56.320177Z","time spent":"319.659135ms","remote":"127.0.0.1:48806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T12:01:56.749717Z","caller":"traceutil/trace.go:171","msg":"trace[49015596] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:562; }","duration":"337.04362ms","start":"2026-04-27T12:01:56.412648Z","end":"2026-04-27T12:01:56.749691Z","steps":["trace[49015596] 'read index received' (duration: 227.005795ms)","trace[49015596] 'applied index is now lower than readState.Index' (duration: 110.036895ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:01:56.749903Z","caller":"traceutil/trace.go:171","msg":"trace[1086846731] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"338.427978ms","start":"2026-04-27T12:01:56.411446Z","end":"2026-04-27T12:01:56.749874Z","steps":["trace[1086846731] 'process raft request' (duration: 337.893805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:01:56.749997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.321261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T12:01:56.750089Z","caller":"traceutil/trace.go:171","msg":"trace[2059296514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:540; }","duration":"337.425362ms","start":"2026-04-27T12:01:56.412642Z","end":"2026-04-27T12:01:56.750068Z","steps":["trace[2059296514] 'agreement among raft nodes before linearized reading' (duration: 337.204241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:01:56.75016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:01:56.412597Z","time spent":"337.546983ms","remote":"127.0.0.1:48986","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-04-27T12:01:56.75035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:01:56.411418Z","time spent":"338.562181ms","remote":"127.0.0.1:48806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T12:02:02.493936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.348029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-27T12:02:02.494057Z","caller":"traceutil/trace.go:171","msg":"trace[697711302] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"276.215661ms","start":"2026-04-27T12:02:02.217823Z","end":"2026-04-27T12:02:02.494039Z","steps":["trace[697711302] 'process raft request' (duration: 114.51991ms)","trace[697711302] 'compare' (duration: 161.173878ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:02:02.984132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.08976ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T12:02:02.984352Z","caller":"traceutil/trace.go:171","msg":"trace[1992772126] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:606; }","duration":"203.695848ms","start":"2026-04-27T12:02:02.780637Z","end":"2026-04-27T12:02:02.984333Z","steps":["trace[1992772126] 'read index received' (duration: 45.68µs)","trace[1992772126] 'applied index is now lower than readState.Index' (duration: 203.649298ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:02:02.984467Z","caller":"traceutil/trace.go:171","msg":"trace[1061807037] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"484.778571ms","start":"2026-04-27T12:02:02.499677Z","end":"2026-04-27T12:02:02.984455Z","steps":["trace[1061807037] 'process raft request' (duration: 219.238538ms)","trace[1061807037] 'compare' (duration: 264.900329ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:02:02.984619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:02:02.499655Z","time spent":"484.911972ms","remote":"127.0.0.1:48922","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T12:02:02.984747Z","caller":"traceutil/trace.go:171","msg":"trace[41832448] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"484.813491ms","start":"2026-04-27T12:02:02.499912Z","end":"2026-04-27T12:02:02.984725Z","steps":["trace[41832448] 'process raft request' (duration: 484.330238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:02:02.984783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.111032ms","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-04-27T12:02:02.984908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.821763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2m2hd\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-27T12:02:02.984922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:02:02.499904Z","time spent":"484.891751ms","remote":"127.0.0.1:48830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T12:02:02.984952Z","caller":"traceutil/trace.go:171","msg":"trace[1863944842] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:584; }","duration":"204.333393ms","start":"2026-04-27T12:02:02.780585Z","end":"2026-04-27T12:02:02.984918Z","steps":["trace[1863944842] 'agreement among raft nodes before linearized reading' (duration: 203.91121ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:02:02.984966Z","caller":"traceutil/trace.go:171","msg":"trace[774844492] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2m2hd; range_end:; response_count:1; response_revision:584; }","duration":"125.927433ms","start":"2026-04-27T12:02:02.859022Z","end":"2026-04-27T12:02:02.984949Z","steps":["trace[774844492] 'agreement among raft nodes before linearized reading' (duration: 125.761702ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:02:02.985034Z","caller":"traceutil/trace.go:171","msg":"trace[1636234290] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"484.987772ms","start":"2026-04-27T12:02:02.500004Z","end":"2026-04-27T12:02:02.984992Z","steps":["trace[1636234290] 'process raft request' (duration: 484.295898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:02:02.985184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:02:02.499978Z","time spent":"485.131873ms","remote":"127.0.0.1:48830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-27T12:02:18.554449Z","caller":"traceutil/trace.go:171","msg":"trace[679901721] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"225.256382ms","start":"2026-04-27T12:02:18.329158Z","end":"2026-04-27T12:02:18.554415Z","steps":["trace[679901721] 'process raft request' (duration: 204.169881ms)","trace[679901721] 'compare' (duration: 20.81635ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:02:18.627402Z","caller":"traceutil/trace.go:171","msg":"trace[631286507] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"296.463583ms","start":"2026-04-27T12:02:18.330911Z","end":"2026-04-27T12:02:18.627374Z","steps":["trace[631286507] 'process raft request' (duration: 296.295066ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:02:47.890186Z","caller":"traceutil/trace.go:171","msg":"trace[930404307] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"168.949944ms","start":"2026-04-27T12:02:47.721206Z","end":"2026-04-27T12:02:47.890156Z","steps":["trace[930404307] 'process raft request' (duration: 168.692626ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:02:47.890502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.83613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T12:02:47.890581Z","caller":"traceutil/trace.go:171","msg":"trace[615325722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1145; }","duration":"167.972864ms","start":"2026-04-27T12:02:47.722595Z","end":"2026-04-27T12:02:47.890568Z","steps":["trace[615325722] 'agreement among raft nodes before linearized reading' (duration: 167.732417ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:02:47.890071Z","caller":"traceutil/trace.go:171","msg":"trace[765027732] linearizableReadLoop","detail":"{readStateIndex:1181; appliedIndex:1180; }","duration":"167.413947ms","start":"2026-04-27T12:02:47.722633Z","end":"2026-04-27T12:02:47.890047Z","steps":["trace[765027732] 'read index received' (duration: 167.192381ms)","trace[765027732] 'applied index is now lower than readState.Index' (duration: 220.636µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:03:32.914796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.518695ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T12:03:32.915168Z","caller":"traceutil/trace.go:171","msg":"trace[434991577] transaction","detail":"{read_only:false; response_revision:1787; number_of_response:1; }","duration":"298.361422ms","start":"2026-04-27T12:03:32.616784Z","end":"2026-04-27T12:03:32.915145Z","steps":["trace[434991577] 'process raft request' (duration: 56.375577ms)","trace[434991577] 'compare' (duration: 241.297671ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:03:32.915288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.261493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T12:03:32.915369Z","caller":"traceutil/trace.go:171","msg":"trace[993845204] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1787; }","duration":"205.390695ms","start":"2026-04-27T12:03:32.709966Z","end":"2026-04-27T12:03:32.915357Z","steps":["trace[993845204] 'agreement among raft nodes before linearized reading' (duration: 205.275542ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:03:32.915109Z","caller":"traceutil/trace.go:171","msg":"trace[1599159152] linearizableReadLoop","detail":"{readStateIndex:1843; appliedIndex:1842; }","duration":"205.063698ms","start":"2026-04-27T12:03:32.710022Z","end":"2026-04-27T12:03:32.915086Z","steps":["trace[1599159152] 'read index received' (duration: 46.631µs)","trace[1599159152] 'applied index is now lower than readState.Index' (duration: 205.015327ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:03:39.895172Z","caller":"traceutil/trace.go:171","msg":"trace[1290768918] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"220.198307ms","start":"2026-04-27T12:03:39.674952Z","end":"2026-04-27T12:03:39.89515Z","steps":["trace[1290768918] 'process raft request' (duration: 220.061104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:04:00.592119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.462987ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T12:04:00.592362Z","caller":"traceutil/trace.go:171","msg":"trace[1171314999] transaction","detail":"{read_only:false; response_revision:2023; number_of_response:1; }","duration":"273.505348ms","start":"2026-04-27T12:04:00.31879Z","end":"2026-04-27T12:04:00.592296Z","steps":["trace[1171314999] 'process raft request' (duration: 83.710786ms)","trace[1171314999] 'compare' (duration: 189.087611ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:04:00.638161Z","caller":"traceutil/trace.go:171","msg":"trace[1969663422] linearizableReadLoop","detail":"{readStateIndex:2091; appliedIndex:2090; }","duration":"167.789857ms","start":"2026-04-27T12:04:00.470345Z","end":"2026-04-27T12:04:00.638135Z","steps":["trace[1969663422] 'read index received' (duration: 167.629595ms)","trace[1969663422] 'applied index is now lower than readState.Index' (duration: 159.332µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:04:00.63824Z","caller":"traceutil/trace.go:171","msg":"trace[803493131] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"252.481079ms","start":"2026-04-27T12:04:00.385726Z","end":"2026-04-27T12:04:00.638207Z","steps":["trace[803493131] 'process raft request' (duration: 252.262836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:04:00.638411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.041801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:659"} {"level":"info","ts":"2026-04-27T12:04:00.638551Z","caller":"traceutil/trace.go:171","msg":"trace[2094240515] range","detail":"{range_begin:/registry/configmaps/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2024; }","duration":"168.217266ms","start":"2026-04-27T12:04:00.470305Z","end":"2026-04-27T12:04:00.638523Z","steps":["trace[2094240515] 'agreement among raft nodes before linearized reading' (duration: 167.958871ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:04:00.787932Z","caller":"traceutil/trace.go:171","msg":"trace[831338938] linearizableReadLoop","detail":"{readStateIndex:2092; appliedIndex:2091; }","duration":"146.011888ms","start":"2026-04-27T12:04:00.64188Z","end":"2026-04-27T12:04:00.787892Z","steps":["trace[831338938] 'read index received' (duration: 103.565205ms)","trace[831338938] 'applied index is now lower than readState.Index' (duration: 42.445093ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:04:00.78806Z","caller":"traceutil/trace.go:171","msg":"trace[420273342] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"177.467174ms","start":"2026-04-27T12:04:00.610547Z","end":"2026-04-27T12:04:00.788015Z","steps":["trace[420273342] 'process raft request' (duration: 134.834168ms)","trace[420273342] 'compare' (duration: 42.29638ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:04:00.788488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.599627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:567"} {"level":"info","ts":"2026-04-27T12:04:00.788563Z","caller":"traceutil/trace.go:171","msg":"trace[1602067979] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2025; }","duration":"146.717369ms","start":"2026-04-27T12:04:00.641826Z","end":"2026-04-27T12:04:00.788544Z","steps":["trace[1602067979] 'agreement among raft nodes before linearized reading' (duration: 146.263582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:04:06.429289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.303475ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T12:04:06.429403Z","caller":"traceutil/trace.go:171","msg":"trace[1236678489] linearizableReadLoop","detail":"{readStateIndex:2129; appliedIndex:2128; }","duration":"199.806367ms","start":"2026-04-27T12:04:06.229577Z","end":"2026-04-27T12:04:06.429384Z","steps":["trace[1236678489] 'read index received' (duration: 70.32669ms)","trace[1236678489] 'applied index is now lower than readState.Index' (duration: 129.478457ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:04:06.42973Z","caller":"traceutil/trace.go:171","msg":"trace[1961571844] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"281.484583ms","start":"2026-04-27T12:04:06.148219Z","end":"2026-04-27T12:04:06.429703Z","steps":["trace[1961571844] 'process raft request' (duration: 151.680761ms)","trace[1961571844] 'compare' (duration: 128.779386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:04:06.429858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.269784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T12:04:06.429929Z","caller":"traceutil/trace.go:171","msg":"trace[438345452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2060; }","duration":"200.375336ms","start":"2026-04-27T12:04:06.229537Z","end":"2026-04-27T12:04:06.429912Z","steps":["trace[438345452] 'agreement among raft nodes before linearized reading' (duration: 200.248625ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:04:06.439713Z","caller":"traceutil/trace.go:171","msg":"trace[1394683223] transaction","detail":"{read_only:false; response_revision:2061; number_of_response:1; }","duration":"184.600122ms","start":"2026-04-27T12:04:06.255098Z","end":"2026-04-27T12:04:06.439698Z","steps":["trace[1394683223] 'process raft request' (duration: 184.399329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:04:06.439916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.90341ms","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-04-27T12:04:06.440086Z","caller":"traceutil/trace.go:171","msg":"trace[1076244146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2061; }","duration":"124.190415ms","start":"2026-04-27T12:04:06.315818Z","end":"2026-04-27T12:04:06.440008Z","steps":["trace[1076244146] 'agreement among raft nodes before linearized reading' (duration: 123.812349ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:04:06.630148Z","caller":"traceutil/trace.go:171","msg":"trace[292342963] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"183.414563ms","start":"2026-04-27T12:04:06.44669Z","end":"2026-04-27T12:04:06.630105Z","steps":["trace[292342963] 'process raft request' (duration: 183.150109ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:04:59.077815Z","caller":"traceutil/trace.go:171","msg":"trace[87112850] linearizableReadLoop","detail":"{readStateIndex:2618; appliedIndex:2617; }","duration":"121.058097ms","start":"2026-04-27T12:04:58.956738Z","end":"2026-04-27T12:04:59.077796Z","steps":["trace[87112850] 'read index received' (duration: 120.932096ms)","trace[87112850] 'applied index is now lower than readState.Index' (duration: 125.301µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:04:59.07789Z","caller":"traceutil/trace.go:171","msg":"trace[1346676740] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"191.181445ms","start":"2026-04-27T12:04:58.886661Z","end":"2026-04-27T12:04:59.077843Z","steps":["trace[1346676740] 'process raft request' (duration: 191.019863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:04:59.078061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.29867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-27T12:04:59.078141Z","caller":"traceutil/trace.go:171","msg":"trace[1667562529] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2524; }","duration":"121.447532ms","start":"2026-04-27T12:04:58.956676Z","end":"2026-04-27T12:04:59.078124Z","steps":["trace[1667562529] 'agreement among raft nodes before linearized reading' (duration: 121.204229ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:05:25.605862Z","caller":"traceutil/trace.go:171","msg":"trace[969461248] linearizableReadLoop","detail":"{readStateIndex:2815; appliedIndex:2814; }","duration":"126.543233ms","start":"2026-04-27T12:05:25.479295Z","end":"2026-04-27T12:05:25.605839Z","steps":["trace[969461248] 'read index received' (duration: 126.313531ms)","trace[969461248] 'applied index is now lower than readState.Index' (duration: 228.832µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:05:25.60629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.732746ms","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-04-27T12:05:25.606347Z","caller":"traceutil/trace.go:171","msg":"trace[2098344798] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2710; }","duration":"127.092921ms","start":"2026-04-27T12:05:25.47924Z","end":"2026-04-27T12:05:25.606333Z","steps":["trace[2098344798] 'agreement among raft nodes before linearized reading' (duration: 126.700605ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:05:25.606332Z","caller":"traceutil/trace.go:171","msg":"trace[706279688] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"150.820439ms","start":"2026-04-27T12:05:25.455489Z","end":"2026-04-27T12:05:25.606309Z","steps":["trace[706279688] 'process raft request' (duration: 150.180801ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:05:25.963879Z","caller":"traceutil/trace.go:171","msg":"trace[1818293447] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"136.491525ms","start":"2026-04-27T12:05:25.82736Z","end":"2026-04-27T12:05:25.963852Z","steps":["trace[1818293447] 'process raft request' (duration: 122.487497ms)","trace[1818293447] 'compare' (duration: 13.533433ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:05:26.182066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.147928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T12:05:26.182197Z","caller":"traceutil/trace.go:171","msg":"trace[57101015] linearizableReadLoop","detail":"{readStateIndex:2818; appliedIndex:2817; }","duration":"125.159486ms","start":"2026-04-27T12:05:26.057018Z","end":"2026-04-27T12:05:26.182177Z","steps":["trace[57101015] 'read index received' (duration: 19.774595ms)","trace[57101015] 'applied index is now lower than readState.Index' (duration: 105.383301ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:05:26.18233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.316277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T12:05:26.182322Z","caller":"traceutil/trace.go:171","msg":"trace[1707361769] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"212.021407ms","start":"2026-04-27T12:05:25.970263Z","end":"2026-04-27T12:05:26.182285Z","steps":["trace[1707361769] 'process raft request' (duration: 106.556025ms)","trace[1707361769] 'compare' (duration: 104.711514ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:05:26.182369Z","caller":"traceutil/trace.go:171","msg":"trace[1329230311] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2713; }","duration":"125.387468ms","start":"2026-04-27T12:05:26.056968Z","end":"2026-04-27T12:05:26.182356Z","steps":["trace[1329230311] 'agreement among raft nodes before linearized reading' (duration: 125.300887ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:05:26.423701Z","caller":"traceutil/trace.go:171","msg":"trace[1247617785] linearizableReadLoop","detail":"{readStateIndex:2820; appliedIndex:2819; }","duration":"193.134603ms","start":"2026-04-27T12:05:26.230543Z","end":"2026-04-27T12:05:26.423677Z","steps":["trace[1247617785] 'read index received' (duration: 178.70771ms)","trace[1247617785] 'applied index is now lower than readState.Index' (duration: 14.425603ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:05:26.423912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.343535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T12:05:26.423977Z","caller":"traceutil/trace.go:171","msg":"trace[484585102] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2715; }","duration":"193.449617ms","start":"2026-04-27T12:05:26.230517Z","end":"2026-04-27T12:05:26.423966Z","steps":["trace[484585102] 'agreement among raft nodes before linearized reading' (duration: 193.331126ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:05:26.424038Z","caller":"traceutil/trace.go:171","msg":"trace[335910225] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"234.043424ms","start":"2026-04-27T12:05:26.189955Z","end":"2026-04-27T12:05:26.423998Z","steps":["trace[335910225] 'process raft request' (duration: 219.324688ms)","trace[335910225] 'compare' (duration: 14.279572ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:05:26.618991Z","caller":"traceutil/trace.go:171","msg":"trace[1443203762] transaction","detail":"{read_only:false; response_revision:2717; number_of_response:1; }","duration":"147.994983ms","start":"2026-04-27T12:05:26.470974Z","end":"2026-04-27T12:05:26.618969Z","steps":["trace[1443203762] 'process raft request' (duration: 143.917018ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:07:59.151641Z","caller":"traceutil/trace.go:171","msg":"trace[1402899102] transaction","detail":"{read_only:false; response_revision:4432; number_of_response:1; }","duration":"109.078085ms","start":"2026-04-27T12:07:59.042528Z","end":"2026-04-27T12:07:59.151606Z","steps":["trace[1402899102] 'process raft request' (duration: 60.083772ms)","trace[1402899102] 'compare' (duration: 48.514983ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T12:08:00.350285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.192237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T12:08:00.350377Z","caller":"traceutil/trace.go:171","msg":"trace[1617801350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4506; }","duration":"122.35586ms","start":"2026-04-27T12:08:00.228003Z","end":"2026-04-27T12:08:00.350358Z","steps":["trace[1617801350] 'range keys from in-memory index tree' (duration: 122.063425ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:08:00.819985Z","caller":"traceutil/trace.go:171","msg":"trace[1955403551] transaction","detail":"{read_only:false; response_revision:4509; number_of_response:1; }","duration":"124.184915ms","start":"2026-04-27T12:08:00.695779Z","end":"2026-04-27T12:08:00.819964Z","steps":["trace[1955403551] 'process raft request' (duration: 115.418209ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:08:00.867637Z","caller":"traceutil/trace.go:171","msg":"trace[1074816934] transaction","detail":"{read_only:false; response_revision:4510; number_of_response:1; }","duration":"163.706044ms","start":"2026-04-27T12:08:00.703895Z","end":"2026-04-27T12:08:00.867601Z","steps":["trace[1074816934] 'process raft request' (duration: 163.47695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:08:12.121112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.254071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T12:08:12.121206Z","caller":"traceutil/trace.go:171","msg":"trace[685130944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4679; }","duration":"301.344742ms","start":"2026-04-27T12:08:11.819832Z","end":"2026-04-27T12:08:12.121177Z","steps":["trace[685130944] 'range keys from in-memory index tree' (duration: 301.116178ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:08:12.121347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.719754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-hknk6\" ","response":"range_response_count:1 size:9901"} {"level":"info","ts":"2026-04-27T12:08:12.121416Z","caller":"traceutil/trace.go:171","msg":"trace[2111760793] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-hknk6; range_end:; response_count:1; response_revision:4679; }","duration":"438.808415ms","start":"2026-04-27T12:08:11.682584Z","end":"2026-04-27T12:08:12.121392Z","steps":["trace[2111760793] 'range keys from in-memory index tree' (duration: 438.574991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:08:12.12148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:08:11.682566Z","time spent":"438.897846ms","remote":"127.0.0.1:48922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":9924,"request content":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-hknk6\" "} {"level":"warn","ts":"2026-04-27T12:08:12.121734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.139665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"warn","ts":"2026-04-27T12:08:12.121248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:08:11.819758Z","time spent":"301.479855ms","remote":"127.0.0.1:48986","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":"info","ts":"2026-04-27T12:08:12.122523Z","caller":"traceutil/trace.go:171","msg":"trace[780646076] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"218.038675ms","start":"2026-04-27T12:08:11.904465Z","end":"2026-04-27T12:08:12.122504Z","steps":["trace[780646076] 'process raft request' (duration: 197.422477ms)","trace[780646076] 'compare' (duration: 18.999928ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:08:12.12265Z","caller":"traceutil/trace.go:171","msg":"trace[268968590] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4679; }","duration":"360.061071ms","start":"2026-04-27T12:08:11.762556Z","end":"2026-04-27T12:08:12.122617Z","steps":["trace[268968590] 'range keys from in-memory index tree' (duration: 358.93488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T12:08:12.122999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T12:08:11.762508Z","time spent":"360.457028ms","remote":"127.0.0.1:48892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-04-27T12:08:12.488068Z","caller":"traceutil/trace.go:171","msg":"trace[1222759937] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"172.780241ms","start":"2026-04-27T12:08:12.315261Z","end":"2026-04-27T12:08:12.488041Z","steps":["trace[1222759937] 'process raft request' (duration: 102.438904ms)","trace[1222759937] 'compare' (duration: 70.145933ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T12:08:12.488444Z","caller":"traceutil/trace.go:171","msg":"trace[1942398952] transaction","detail":"{read_only:false; response_revision:4693; number_of_response:1; }","duration":"171.001599ms","start":"2026-04-27T12:08:12.3174Z","end":"2026-04-27T12:08:12.488402Z","steps":["trace[1942398952] 'process raft request' (duration: 170.590762ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:08:12.488581Z","caller":"traceutil/trace.go:171","msg":"trace[1474061381] transaction","detail":"{read_only:false; response_revision:4694; number_of_response:1; }","duration":"167.424353ms","start":"2026-04-27T12:08:12.321135Z","end":"2026-04-27T12:08:12.488559Z","steps":["trace[1474061381] 'process raft request' (duration: 167.055455ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:08:12.48881Z","caller":"traceutil/trace.go:171","msg":"trace[1624998286] transaction","detail":"{read_only:false; response_revision:4695; number_of_response:1; }","duration":"160.581648ms","start":"2026-04-27T12:08:12.32821Z","end":"2026-04-27T12:08:12.488792Z","steps":["trace[1624998286] 'process raft request' (duration: 160.239341ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T12:11:25.983503Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3209} {"level":"info","ts":"2026-04-27T12:11:26.070438Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3209,"took":"85.653074ms","hash":1364265557,"current-db-size-bytes":58826752,"current-db-size":"59 MB","current-db-size-in-use-bytes":31461376,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-27T12:11:26.070526Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1364265557,"revision":3209,"compact-revision":-1}