{"level":"warn","ts":"2026-05-06T01:11:14.324463Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T01:11:14.324585Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.235: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.235:2380","--initial-cluster=instance=https://199.19.213.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.235:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-06T01:11:14.324661Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-06T01:11:14.324676Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-05-06T01:11:14.324696Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T01:11:14.325558Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"]} {"level":"info","ts":"2026-05-06T01:11:14.325682Z","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.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.235:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-06T01:11:14.341321Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"13.450118ms"} {"level":"info","ts":"2026-05-06T01:11:14.380811Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"61a3fe3fc9dc5d35","cluster-id":"e13fd0e1d9ce1168"} {"level":"info","ts":"2026-05-06T01:11:14.380915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T01:11:14.380942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 0"} {"level":"info","ts":"2026-05-06T01:11:14.380952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 61a3fe3fc9dc5d35 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T01:11:14.380964Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became follower at term 1"} {"level":"info","ts":"2026-05-06T01:11:14.381007Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"warn","ts":"2026-05-06T01:11:14.409785Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T01:11:14.412067Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T01:11:14.428075Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-06T01:11:14.432881Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"61a3fe3fc9dc5d35","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T01:11:14.436045Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"61a3fe3fc9dc5d35","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T01:11:14.43785Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T01:11:14.437953Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T01:11:14.437968Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-06T01:11:14.440814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 switched to configuration voters=(7035746592805903669)"} {"level":"info","ts":"2026-05-06T01:11:14.445425Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","added-peer-id":"61a3fe3fc9dc5d35","added-peer-peer-urls":["https://199.19.213.235:2380"]} {"level":"info","ts":"2026-05-06T01:11:14.446096Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-06T01:11:14.446354Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"61a3fe3fc9dc5d35","initial-advertise-peer-urls":["https://199.19.213.235:2380"],"listen-peer-urls":["https://199.19.213.235:2380"],"advertise-client-urls":["https://199.19.213.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T01:11:14.446318Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-05-06T01:11:14.446483Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.235:2380"} {"level":"info","ts":"2026-05-06T01:11:14.446455Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T01:11:15.184645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T01:11:15.184715Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T01:11:15.18475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgPreVoteResp from 61a3fe3fc9dc5d35 at term 1"} {"level":"info","ts":"2026-05-06T01:11:15.184762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became candidate at term 2"} {"level":"info","ts":"2026-05-06T01:11:15.184767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 received MsgVoteResp from 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-05-06T01:11:15.184776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61a3fe3fc9dc5d35 became leader at term 2"} {"level":"info","ts":"2026-05-06T01:11:15.184782Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 61a3fe3fc9dc5d35 elected leader 61a3fe3fc9dc5d35 at term 2"} {"level":"info","ts":"2026-05-06T01:11:15.188793Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:11:15.189672Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T01:11:15.189667Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"61a3fe3fc9dc5d35","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.235:2379]}","request-path":"/0/members/61a3fe3fc9dc5d35/attributes","cluster-id":"e13fd0e1d9ce1168","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T01:11:15.18977Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T01:11:15.190751Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T01:11:15.190828Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T01:11:15.190723Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e13fd0e1d9ce1168","local-member-id":"61a3fe3fc9dc5d35","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:11:15.191857Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:11:15.191886Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T01:11:15.192772Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T01:11:15.193769Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.235:2379"} {"level":"info","ts":"2026-05-06T01:11:21.725843Z","caller":"traceutil/trace.go:171","msg":"trace[2123161822] linearizableReadLoop","detail":"{readStateIndex:286; appliedIndex:285; }","duration":"106.993632ms","start":"2026-05-06T01:11:21.618811Z","end":"2026-05-06T01:11:21.725805Z","steps":["trace[2123161822] 'read index received' (duration: 104.807111ms)","trace[2123161822] 'applied index is now lower than readState.Index' (duration: 2.184861ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:11:21.725958Z","caller":"traceutil/trace.go:171","msg":"trace[1210235115] transaction","detail":"{read_only:false; response_revision:273; number_of_response:1; }","duration":"122.607201ms","start":"2026-05-06T01:11:21.603298Z","end":"2026-05-06T01:11:21.725905Z","steps":["trace[1210235115] 'process raft request' (duration: 120.297138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:21.726155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.231926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-06T01:11:21.726307Z","caller":"traceutil/trace.go:171","msg":"trace[1328249081] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:273; }","duration":"107.519311ms","start":"2026-05-06T01:11:21.618772Z","end":"2026-05-06T01:11:21.726291Z","steps":["trace[1328249081] 'agreement among raft nodes before linearized reading' (duration: 107.204655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:22.132575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.170183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:11:22.13269Z","caller":"traceutil/trace.go:171","msg":"trace[1482510362] linearizableReadLoop","detail":"{readStateIndex:288; appliedIndex:286; }","duration":"354.239489ms","start":"2026-05-06T01:11:21.778434Z","end":"2026-05-06T01:11:22.132673Z","steps":["trace[1482510362] 'read index received' (duration: 11.195658ms)","trace[1482510362] 'applied index is now lower than readState.Index' (duration: 343.042341ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:11:22.132801Z","caller":"traceutil/trace.go:171","msg":"trace[1955919025] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"396.513791ms","start":"2026-05-06T01:11:21.736277Z","end":"2026-05-06T01:11:22.132791Z","steps":["trace[1955919025] 'process raft request' (duration: 241.543115ms)","trace[1955919025] 'compare' (duration: 154.014478ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:11:22.132869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:11:21.736259Z","time spent":"396.578762ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T01:11:22.133056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.637127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-06T01:11:22.133134Z","caller":"traceutil/trace.go:171","msg":"trace[238175527] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:275; }","duration":"339.76505ms","start":"2026-05-06T01:11:21.793349Z","end":"2026-05-06T01:11:22.133114Z","steps":["trace[238175527] 'agreement among raft nodes before linearized reading' (duration: 339.592727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:22.133171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:11:21.793327Z","time spent":"339.835751ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" "} {"level":"warn","ts":"2026-05-06T01:11:22.133264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-06T01:11:22.133298Z","caller":"traceutil/trace.go:171","msg":"trace[1571235857] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:275; }","duration":"354.89623ms","start":"2026-05-06T01:11:21.778392Z","end":"2026-05-06T01:11:22.133288Z","steps":["trace[1571235857] 'agreement among raft nodes before linearized reading' (duration: 354.824849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:22.133328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:11:21.778371Z","time spent":"354.951392ms","remote":"127.0.0.1:50164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-06T01:11:22.133364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.665237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T01:11:22.1334Z","caller":"traceutil/trace.go:171","msg":"trace[434006239] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:275; }","duration":"218.715758ms","start":"2026-05-06T01:11:21.914666Z","end":"2026-05-06T01:11:22.133382Z","steps":["trace[434006239] 'agreement among raft nodes before linearized reading' (duration: 218.661277ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:22.255894Z","caller":"traceutil/trace.go:171","msg":"trace[1144402156] transaction","detail":"{read_only:false; response_revision:276; number_of_response:1; }","duration":"118.245118ms","start":"2026-05-06T01:11:22.137621Z","end":"2026-05-06T01:11:22.255867Z","steps":["trace[1144402156] 'process raft request' (duration: 111.323191ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:22.256716Z","caller":"traceutil/trace.go:171","msg":"trace[805179212] linearizableReadLoop","detail":"{readStateIndex:290; appliedIndex:288; }","duration":"116.531837ms","start":"2026-05-06T01:11:22.140164Z","end":"2026-05-06T01:11:22.256695Z","steps":["trace[805179212] 'read index received' (duration: 108.794635ms)","trace[805179212] 'applied index is now lower than readState.Index' (duration: 7.735742ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:11:22.25674Z","caller":"traceutil/trace.go:171","msg":"trace[467763172] transaction","detail":"{read_only:false; response_revision:277; number_of_response:1; }","duration":"116.593818ms","start":"2026-05-06T01:11:22.140127Z","end":"2026-05-06T01:11:22.25672Z","steps":["trace[467763172] 'process raft request' (duration: 116.417295ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:22.256868Z","caller":"traceutil/trace.go:171","msg":"trace[702466762] transaction","detail":"{read_only:false; response_revision:278; number_of_response:1; }","duration":"114.170134ms","start":"2026-05-06T01:11:22.142679Z","end":"2026-05-06T01:11:22.256849Z","steps":["trace[702466762] 'process raft request' (duration: 113.95459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:22.256917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.73834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-06T01:11:22.256957Z","caller":"traceutil/trace.go:171","msg":"trace[2016439678] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:278; }","duration":"116.844032ms","start":"2026-05-06T01:11:22.140102Z","end":"2026-05-06T01:11:22.256946Z","steps":["trace[2016439678] 'agreement among raft nodes before linearized reading' (duration: 116.756081ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:24.266292Z","caller":"traceutil/trace.go:171","msg":"trace[181890014] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"166.178599ms","start":"2026-05-06T01:11:24.100086Z","end":"2026-05-06T01:11:24.266264Z","steps":["trace[181890014] 'process raft request' (duration: 165.999976ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:24.452924Z","caller":"traceutil/trace.go:171","msg":"trace[1103318335] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:306; }","duration":"333.145984ms","start":"2026-05-06T01:11:24.119693Z","end":"2026-05-06T01:11:24.452839Z","steps":["trace[1103318335] 'read index received' (duration: 146.498835ms)","trace[1103318335] 'applied index is now lower than readState.Index' (duration: 186.645688ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:11:24.453086Z","caller":"traceutil/trace.go:171","msg":"trace[1845303931] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"350.507416ms","start":"2026-05-06T01:11:24.102519Z","end":"2026-05-06T01:11:24.453027Z","steps":["trace[1845303931] 'process raft request' (duration: 344.304944ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:24.453166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.241646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-05-06T01:11:24.453281Z","caller":"traceutil/trace.go:171","msg":"trace[2076412821] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:295; }","duration":"283.442689ms","start":"2026-05-06T01:11:24.16982Z","end":"2026-05-06T01:11:24.453263Z","steps":["trace[2076412821] 'agreement among raft nodes before linearized reading' (duration: 283.272386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:24.453316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.016451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-06T01:11:24.453285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.138727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-06T01:11:24.453383Z","caller":"traceutil/trace.go:171","msg":"trace[1165586166] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:295; }","duration":"184.190314ms","start":"2026-05-06T01:11:24.269176Z","end":"2026-05-06T01:11:24.453366Z","steps":["trace[1165586166] 'agreement among raft nodes before linearized reading' (duration: 183.97255ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:24.453382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:11:24.102435Z","time spent":"350.789921ms","remote":"127.0.0.1:50082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4781,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:11:24.453441Z","caller":"traceutil/trace.go:171","msg":"trace[1798486752] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"192.305419ms","start":"2026-05-06T01:11:24.261098Z","end":"2026-05-06T01:11:24.453404Z","steps":["trace[1798486752] 'agreement among raft nodes before linearized reading' (duration: 192.104916ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:24.453562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.847661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-06T01:11:24.453642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.94935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-06T01:11:24.453677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.194261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-05-06T01:11:24.453685Z","caller":"traceutil/trace.go:171","msg":"trace[909588128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:295; }","duration":"187.071775ms","start":"2026-05-06T01:11:24.266583Z","end":"2026-05-06T01:11:24.453654Z","steps":["trace[909588128] 'agreement among raft nodes before linearized reading' (duration: 186.704828ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:24.453706Z","caller":"traceutil/trace.go:171","msg":"trace[297108759] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:295; }","duration":"134.047211ms","start":"2026-05-06T01:11:24.319641Z","end":"2026-05-06T01:11:24.453688Z","steps":["trace[297108759] 'agreement among raft nodes before linearized reading' (duration: 133.94788ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:24.453718Z","caller":"traceutil/trace.go:171","msg":"trace[443105648] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:295; }","duration":"235.292173ms","start":"2026-05-06T01:11:24.218415Z","end":"2026-05-06T01:11:24.453707Z","steps":["trace[443105648] 'agreement among raft nodes before linearized reading' (duration: 235.220371ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:24.454073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.211257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T01:11:24.454127Z","caller":"traceutil/trace.go:171","msg":"trace[64063461] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:295; }","duration":"193.390609ms","start":"2026-05-06T01:11:24.260721Z","end":"2026-05-06T01:11:24.454112Z","steps":["trace[64063461] 'agreement among raft nodes before linearized reading' (duration: 193.119684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:24.45457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.865465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-06T01:11:24.454626Z","caller":"traceutil/trace.go:171","msg":"trace[1845342370] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:295; }","duration":"334.992557ms","start":"2026-05-06T01:11:24.119616Z","end":"2026-05-06T01:11:24.454609Z","steps":["trace[1845342370] 'agreement among raft nodes before linearized reading' (duration: 333.454179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:24.454677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:11:24.119588Z","time spent":"335.079859ms","remote":"127.0.0.1:50102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-05-06T01:11:45.712374Z","caller":"traceutil/trace.go:171","msg":"trace[489116127] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"139.885011ms","start":"2026-05-06T01:11:45.572463Z","end":"2026-05-06T01:11:45.712348Z","steps":["trace[489116127] 'process raft request' (duration: 139.759949ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.71762Z","caller":"traceutil/trace.go:171","msg":"trace[448797415] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"129.022063ms","start":"2026-05-06T01:11:45.588572Z","end":"2026-05-06T01:11:45.717594Z","steps":["trace[448797415] 'process raft request' (duration: 128.804299ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.717827Z","caller":"traceutil/trace.go:171","msg":"trace[1044586790] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"129.141615ms","start":"2026-05-06T01:11:45.588656Z","end":"2026-05-06T01:11:45.717798Z","steps":["trace[1044586790] 'process raft request' (duration: 128.81946ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.717721Z","caller":"traceutil/trace.go:171","msg":"trace[361452039] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"128.973072ms","start":"2026-05-06T01:11:45.5887Z","end":"2026-05-06T01:11:45.717673Z","steps":["trace[361452039] 'process raft request' (duration: 128.809249ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.718014Z","caller":"traceutil/trace.go:171","msg":"trace[1545565010] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"120.441371ms","start":"2026-05-06T01:11:45.597546Z","end":"2026-05-06T01:11:45.717987Z","steps":["trace[1545565010] 'process raft request' (duration: 120.119746ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.718058Z","caller":"traceutil/trace.go:171","msg":"trace[652339196] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"118.333707ms","start":"2026-05-06T01:11:45.59971Z","end":"2026-05-06T01:11:45.718044Z","steps":["trace[652339196] 'process raft request' (duration: 117.992002ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.718126Z","caller":"traceutil/trace.go:171","msg":"trace[806916593] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"120.654703ms","start":"2026-05-06T01:11:45.597388Z","end":"2026-05-06T01:11:45.718043Z","steps":["trace[806916593] 'process raft request' (duration: 120.145796ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.718195Z","caller":"traceutil/trace.go:171","msg":"trace[123453220] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"114.62044ms","start":"2026-05-06T01:11:45.603551Z","end":"2026-05-06T01:11:45.718172Z","steps":["trace[123453220] 'process raft request' (duration: 114.185364ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:45.718207Z","caller":"traceutil/trace.go:171","msg":"trace[1226892378] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"120.692344ms","start":"2026-05-06T01:11:45.597482Z","end":"2026-05-06T01:11:45.718174Z","steps":["trace[1226892378] 'process raft request' (duration: 120.132636ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:52.799234Z","caller":"traceutil/trace.go:171","msg":"trace[1566983431] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"188.53089ms","start":"2026-05-06T01:11:52.610672Z","end":"2026-05-06T01:11:52.799203Z","steps":["trace[1566983431] 'process raft request' (duration: 188.279926ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:52.799594Z","caller":"traceutil/trace.go:171","msg":"trace[2022541040] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"185.738968ms","start":"2026-05-06T01:11:52.61384Z","end":"2026-05-06T01:11:52.799579Z","steps":["trace[2022541040] 'process raft request' (duration: 185.304472ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:52.799577Z","caller":"traceutil/trace.go:171","msg":"trace[860627174] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:594; }","duration":"185.388423ms","start":"2026-05-06T01:11:52.614149Z","end":"2026-05-06T01:11:52.799537Z","steps":["trace[860627174] 'read index received' (duration: 9.134426ms)","trace[860627174] 'applied index is now lower than readState.Index' (duration: 176.252177ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:11:52.799767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.580166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T01:11:52.799804Z","caller":"traceutil/trace.go:171","msg":"trace[54814197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:572; }","duration":"185.664898ms","start":"2026-05-06T01:11:52.614131Z","end":"2026-05-06T01:11:52.799796Z","steps":["trace[54814197] 'agreement among raft nodes before linearized reading' (duration: 185.529756ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:11:53.289591Z","caller":"traceutil/trace.go:171","msg":"trace[1550692281] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"622.100404ms","start":"2026-05-06T01:11:52.667456Z","end":"2026-05-06T01:11:53.289557Z","steps":["trace[1550692281] 'process raft request' (duration: 562.688353ms)","trace[1550692281] 'compare' (duration: 58.739151ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:11:53.289746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:11:52.667426Z","time spent":"622.239976ms","remote":"127.0.0.1:49964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036189,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:11:53.307771Z","caller":"traceutil/trace.go:171","msg":"trace[1946868523] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"499.376074ms","start":"2026-05-06T01:11:52.808373Z","end":"2026-05-06T01:11:53.307749Z","steps":["trace[1946868523] 'process raft request' (duration: 499.272842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:11:53.307885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:11:52.808345Z","time spent":"499.480095ms","remote":"127.0.0.1:50164","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:11:54.905283Z","caller":"traceutil/trace.go:171","msg":"trace[588733326] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"106.8916ms","start":"2026-05-06T01:11:54.798362Z","end":"2026-05-06T01:11:54.905253Z","steps":["trace[588733326] 'process raft request' (duration: 100.11066ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:12:08.775016Z","caller":"traceutil/trace.go:171","msg":"trace[1191654760] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"162.158938ms","start":"2026-05-06T01:12:08.612826Z","end":"2026-05-06T01:12:08.774985Z","steps":["trace[1191654760] 'process raft request' (duration: 161.883265ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:27.371805Z","caller":"traceutil/trace.go:171","msg":"trace[1433547288] linearizableReadLoop","detail":"{readStateIndex:1878; appliedIndex:1877; }","duration":"262.522899ms","start":"2026-05-06T01:13:27.109243Z","end":"2026-05-06T01:13:27.371766Z","steps":["trace[1433547288] 'read index received' (duration: 262.275924ms)","trace[1433547288] 'applied index is now lower than readState.Index' (duration: 245.655µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:13:27.371905Z","caller":"traceutil/trace.go:171","msg":"trace[1501587697] transaction","detail":"{read_only:false; response_revision:1806; number_of_response:1; }","duration":"273.120952ms","start":"2026-05-06T01:13:27.098758Z","end":"2026-05-06T01:13:27.371879Z","steps":["trace[1501587697] 'process raft request' (duration: 272.748599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:27.372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.733522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:13:27.372157Z","caller":"traceutil/trace.go:171","msg":"trace[1552750196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1806; }","duration":"262.87281ms","start":"2026-05-06T01:13:27.109202Z","end":"2026-05-06T01:13:27.372075Z","steps":["trace[1552750196] 'agreement among raft nodes before linearized reading' (duration: 262.693319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:27.378736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.301742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-06T01:13:27.378818Z","caller":"traceutil/trace.go:171","msg":"trace[1431743788] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1807; }","duration":"143.44764ms","start":"2026-05-06T01:13:27.235355Z","end":"2026-05-06T01:13:27.378803Z","steps":["trace[1431743788] 'agreement among raft nodes before linearized reading' (duration: 143.241108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:13:27.378945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.252404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-06T01:13:27.379022Z","caller":"traceutil/trace.go:171","msg":"trace[1000247312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1807; }","duration":"189.410755ms","start":"2026-05-06T01:13:27.189592Z","end":"2026-05-06T01:13:27.379003Z","steps":["trace[1000247312] 'agreement among raft nodes before linearized reading' (duration: 189.160169ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:27.523746Z","caller":"traceutil/trace.go:171","msg":"trace[988636671] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"138.983326ms","start":"2026-05-06T01:13:27.384732Z","end":"2026-05-06T01:13:27.523715Z","steps":["trace[988636671] 'process raft request' (duration: 138.711668ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:13:27.524225Z","caller":"traceutil/trace.go:171","msg":"trace[1441131413] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"139.36357ms","start":"2026-05-06T01:13:27.384834Z","end":"2026-05-06T01:13:27.524197Z","steps":["trace[1441131413] 'process raft request' (duration: 138.780363ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:01.657974Z","caller":"traceutil/trace.go:171","msg":"trace[1201202778] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"165.49034ms","start":"2026-05-06T01:14:01.492446Z","end":"2026-05-06T01:14:01.657937Z","steps":["trace[1201202778] 'process raft request' (duration: 165.304192ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:01.664981Z","caller":"traceutil/trace.go:171","msg":"trace[1524831658] linearizableReadLoop","detail":"{readStateIndex:2131; appliedIndex:2129; }","duration":"120.04649ms","start":"2026-05-06T01:14:01.544896Z","end":"2026-05-06T01:14:01.664942Z","steps":["trace[1524831658] 'read index received' (duration: 112.956388ms)","trace[1524831658] 'applied index is now lower than readState.Index' (duration: 7.088232ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:01.665097Z","caller":"traceutil/trace.go:171","msg":"trace[557674152] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"157.04673ms","start":"2026-05-06T01:14:01.508011Z","end":"2026-05-06T01:14:01.665058Z","steps":["trace[557674152] 'process raft request' (duration: 156.710654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:01.665259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.358295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12382"} {"level":"info","ts":"2026-05-06T01:14:01.665442Z","caller":"traceutil/trace.go:171","msg":"trace[1130554528] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2052; }","duration":"120.515171ms","start":"2026-05-06T01:14:01.544876Z","end":"2026-05-06T01:14:01.665391Z","steps":["trace[1130554528] 'agreement among raft nodes before linearized reading' (duration: 120.275751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:02.081325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.591999ms","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":"warn","ts":"2026-05-06T01:14:02.081395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.238958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-06T01:14:02.08146Z","caller":"traceutil/trace.go:171","msg":"trace[1615873017] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2053; }","duration":"324.722844ms","start":"2026-05-06T01:14:01.75668Z","end":"2026-05-06T01:14:02.081403Z","steps":["trace[1615873017] 'range keys from in-memory index tree' (duration: 324.410021ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:02.082654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:01.756671Z","time spent":"325.966069ms","remote":"127.0.0.1:50164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-06T01:14:02.081548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.929661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-05-06T01:14:02.082537Z","caller":"traceutil/trace.go:171","msg":"trace[1629601339] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2053; }","duration":"319.358888ms","start":"2026-05-06T01:14:01.763082Z","end":"2026-05-06T01:14:02.082441Z","steps":["trace[1629601339] 'range keys from in-memory index tree' (duration: 318.04153ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:14:02.082833Z","caller":"traceutil/trace.go:171","msg":"trace[1386591246] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2053; }","duration":"258.23658ms","start":"2026-05-06T01:14:01.824577Z","end":"2026-05-06T01:14:02.082813Z","steps":["trace[1386591246] 'range keys from in-memory index tree' (duration: 256.801926ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:02.082873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:01.76306Z","time spent":"319.792117ms","remote":"127.0.0.1:50164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-05-06T01:14:02.081873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.884597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-05-06T01:14:02.081848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.764713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-06T01:14:02.083121Z","caller":"traceutil/trace.go:171","msg":"trace[2017586187] transaction","detail":"{read_only:false; response_revision:2054; number_of_response:1; }","duration":"203.817155ms","start":"2026-05-06T01:14:01.879288Z","end":"2026-05-06T01:14:02.083105Z","steps":["trace[2017586187] 'process raft request' (duration: 51.650122ms)","trace[2017586187] 'compare' (duration: 150.090722ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:14:02.083135Z","caller":"traceutil/trace.go:171","msg":"trace[430671778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2053; }","duration":"328.129923ms","start":"2026-05-06T01:14:01.754971Z","end":"2026-05-06T01:14:02.083101Z","steps":["trace[430671778] 'range keys from in-memory index tree' (duration: 326.355025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:14:02.083201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:14:01.754953Z","time spent":"328.228788ms","remote":"127.0.0.1:50164","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-06T01:15:40.28567Z","caller":"traceutil/trace.go:171","msg":"trace[1094060045] transaction","detail":"{read_only:false; response_revision:2688; number_of_response:1; }","duration":"133.076887ms","start":"2026-05-06T01:15:40.152573Z","end":"2026-05-06T01:15:40.28565Z","steps":["trace[1094060045] 'process raft request' (duration: 132.902283ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:15:40.765574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.396795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-05-06T01:15:40.765655Z","caller":"traceutil/trace.go:171","msg":"trace[1023531249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2689; }","duration":"147.530608ms","start":"2026-05-06T01:15:40.618106Z","end":"2026-05-06T01:15:40.765636Z","steps":["trace[1023531249] 'range keys from in-memory index tree' (duration: 147.269442ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:33.658495Z","caller":"traceutil/trace.go:171","msg":"trace[1717204344] transaction","detail":"{read_only:false; response_revision:4645; number_of_response:1; }","duration":"141.713293ms","start":"2026-05-06T01:19:33.516751Z","end":"2026-05-06T01:19:33.658464Z","steps":["trace[1717204344] 'process raft request' (duration: 141.529438ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:34.027011Z","caller":"traceutil/trace.go:171","msg":"trace[1496438096] linearizableReadLoop","detail":"{readStateIndex:4823; appliedIndex:4822; }","duration":"111.635061ms","start":"2026-05-06T01:19:33.915359Z","end":"2026-05-06T01:19:34.026994Z","steps":["trace[1496438096] 'read index received' (duration: 111.507338ms)","trace[1496438096] 'applied index is now lower than readState.Index' (duration: 127.043µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:19:34.027175Z","caller":"traceutil/trace.go:171","msg":"trace[1243431784] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"145.604994ms","start":"2026-05-06T01:19:33.881431Z","end":"2026-05-06T01:19:34.027036Z","steps":["trace[1243431784] 'process raft request' (duration: 145.44023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:34.027219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.838647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-05-06T01:19:34.027365Z","caller":"traceutil/trace.go:171","msg":"trace[457199767] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4649; }","duration":"112.033212ms","start":"2026-05-06T01:19:33.915309Z","end":"2026-05-06T01:19:34.027342Z","steps":["trace[457199767] 'agreement among raft nodes before linearized reading' (duration: 111.748484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:34.157742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.810189ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-06T01:19:34.157976Z","caller":"traceutil/trace.go:171","msg":"trace[1395110567] transaction","detail":"{read_only:false; response_revision:4651; number_of_response:1; }","duration":"124.741364ms","start":"2026-05-06T01:19:34.033223Z","end":"2026-05-06T01:19:34.157964Z","steps":["trace[1395110567] 'process raft request' (duration: 124.676992ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:34.157957Z","caller":"traceutil/trace.go:171","msg":"trace[1693080020] linearizableReadLoop","detail":"{readStateIndex:4824; appliedIndex:4823; }","duration":"130.878632ms","start":"2026-05-06T01:19:34.027051Z","end":"2026-05-06T01:19:34.15793Z","steps":["trace[1693080020] 'read index received' (duration: 7.97387ms)","trace[1693080020] 'applied index is now lower than readState.Index' (duration: 122.902662ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:19:34.158023Z","caller":"traceutil/trace.go:171","msg":"trace[1630633413] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"124.820377ms","start":"2026-05-06T01:19:34.03317Z","end":"2026-05-06T01:19:34.15799Z","steps":["trace[1630633413] 'process raft request' (duration: 124.647472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:34.158219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.218747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:19:34.158243Z","caller":"traceutil/trace.go:171","msg":"trace[233756389] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4652; }","duration":"230.31404ms","start":"2026-05-06T01:19:33.927921Z","end":"2026-05-06T01:19:34.158235Z","steps":["trace[233756389] 'agreement among raft nodes before linearized reading' (duration: 230.134015ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:34.158364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.254996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-c63134e4-a4e8-4c98-89ca-e13663a42168\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-05-06T01:19:34.158428Z","caller":"traceutil/trace.go:171","msg":"trace[23872105] range","detail":"{range_begin:/registry/persistentvolumes/pvc-c63134e4-a4e8-4c98-89ca-e13663a42168; range_end:; response_count:1; response_revision:4653; }","duration":"128.360089ms","start":"2026-05-06T01:19:34.030052Z","end":"2026-05-06T01:19:34.158412Z","steps":["trace[23872105] 'agreement among raft nodes before linearized reading' (duration: 128.170653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:34.158464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.761204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-06T01:19:34.15848Z","caller":"traceutil/trace.go:171","msg":"trace[1336683203] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4653; }","duration":"115.788896ms","start":"2026-05-06T01:19:34.042686Z","end":"2026-05-06T01:19:34.158475Z","steps":["trace[1336683203] 'agreement among raft nodes before linearized reading' (duration: 115.711953ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:34.158558Z","caller":"traceutil/trace.go:171","msg":"trace[1626372423] transaction","detail":"{read_only:false; response_revision:4652; number_of_response:1; }","duration":"125.129796ms","start":"2026-05-06T01:19:34.033412Z","end":"2026-05-06T01:19:34.158542Z","steps":["trace[1626372423] 'process raft request' (duration: 124.525238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:34.158655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.262189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-06T01:19:34.158686Z","caller":"traceutil/trace.go:171","msg":"trace[1302695559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4653; }","duration":"125.31204ms","start":"2026-05-06T01:19:34.033364Z","end":"2026-05-06T01:19:34.158676Z","steps":["trace[1302695559] 'agreement among raft nodes before linearized reading' (duration: 125.223928ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:34.1587Z","caller":"traceutil/trace.go:171","msg":"trace[1093288186] transaction","detail":"{read_only:false; response_revision:4653; number_of_response:1; }","duration":"124.104896ms","start":"2026-05-06T01:19:34.034577Z","end":"2026-05-06T01:19:34.158682Z","steps":["trace[1093288186] 'process raft request' (duration: 123.55019ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:34.158968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.72437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-05-06T01:19:34.15899Z","caller":"traceutil/trace.go:171","msg":"trace[811303369] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4653; }","duration":"128.761841ms","start":"2026-05-06T01:19:34.030221Z","end":"2026-05-06T01:19:34.158983Z","steps":["trace[811303369] 'agreement among raft nodes before linearized reading' (duration: 128.704089ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:34.325758Z","caller":"traceutil/trace.go:171","msg":"trace[900843768] transaction","detail":"{read_only:false; response_revision:4663; number_of_response:1; }","duration":"101.0555ms","start":"2026-05-06T01:19:34.224671Z","end":"2026-05-06T01:19:34.325727Z","steps":["trace[900843768] 'process raft request' (duration: 100.760281ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:34.325957Z","caller":"traceutil/trace.go:171","msg":"trace[162565695] transaction","detail":"{read_only:false; response_revision:4664; number_of_response:1; }","duration":"100.967568ms","start":"2026-05-06T01:19:34.224962Z","end":"2026-05-06T01:19:34.32593Z","steps":["trace[162565695] 'process raft request' (duration: 100.633058ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:19:34.325524Z","caller":"traceutil/trace.go:171","msg":"trace[2064269233] transaction","detail":"{read_only:false; response_revision:4662; number_of_response:1; }","duration":"100.878315ms","start":"2026-05-06T01:19:34.224618Z","end":"2026-05-06T01:19:34.325496Z","steps":["trace[2064269233] 'process raft request' (duration: 100.632708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:45.391595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.62537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T01:19:45.391735Z","caller":"traceutil/trace.go:171","msg":"trace[456380314] transaction","detail":"{read_only:false; response_revision:4881; number_of_response:1; }","duration":"330.60406ms","start":"2026-05-06T01:19:45.061099Z","end":"2026-05-06T01:19:45.391703Z","steps":["trace[456380314] 'process raft request' (duration: 132.788225ms)","trace[456380314] 'compare' (duration: 197.516417ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T01:19:45.391791Z","caller":"traceutil/trace.go:171","msg":"trace[1148423680] transaction","detail":"{read_only:false; response_revision:4882; number_of_response:1; }","duration":"257.695408ms","start":"2026-05-06T01:19:45.134079Z","end":"2026-05-06T01:19:45.391774Z","steps":["trace[1148423680] 'process raft request' (duration: 257.629117ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:45.391853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:19:45.061083Z","time spent":"330.709444ms","remote":"127.0.0.1:50384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":15332,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T01:19:45.391999Z","caller":"traceutil/trace.go:171","msg":"trace[1780040375] linearizableReadLoop","detail":"{readStateIndex:5060; appliedIndex:5059; }","duration":"310.111751ms","start":"2026-05-06T01:19:45.081879Z","end":"2026-05-06T01:19:45.39199Z","steps":["trace[1780040375] 'read index received' (duration: 111.919175ms)","trace[1780040375] 'applied index is now lower than readState.Index' (duration: 198.191726ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T01:19:45.392155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.281136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-06T01:19:45.392186Z","caller":"traceutil/trace.go:171","msg":"trace[620352109] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4882; }","duration":"310.343638ms","start":"2026-05-06T01:19:45.081833Z","end":"2026-05-06T01:19:45.392176Z","steps":["trace[620352109] 'agreement among raft nodes before linearized reading' (duration: 310.247955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T01:19:45.392263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T01:19:45.081782Z","time spent":"310.473062ms","remote":"127.0.0.1:50048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-05-06T01:19:45.392268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.334614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T01:19:45.392361Z","caller":"traceutil/trace.go:171","msg":"trace[590008637] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4882; }","duration":"283.475287ms","start":"2026-05-06T01:19:45.108865Z","end":"2026-05-06T01:19:45.39234Z","steps":["trace[590008637] 'agreement among raft nodes before linearized reading' (duration: 283.288552ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T01:21:15.21413Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2874} {"level":"info","ts":"2026-05-06T01:21:15.299252Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2874,"took":"83.677789ms","hash":1137471173,"current-db-size-bytes":54206464,"current-db-size":"54 MB","current-db-size-in-use-bytes":29257728,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-06T01:21:15.29932Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1137471173,"revision":2874,"compact-revision":-1} {"level":"info","ts":"2026-05-06T01:26:15.219479Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5609} {"level":"info","ts":"2026-05-06T01:26:15.302086Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5609,"took":"81.001557ms","hash":925392142,"current-db-size-bytes":54206464,"current-db-size":"54 MB","current-db-size-in-use-bytes":18255872,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-06T01:26:15.302153Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":925392142,"revision":5609,"compact-revision":2874}