{"level":"warn","ts":"2026-08-25T19:10:13.612797Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-25T19:10:13.612886Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.116:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.116:2380","--initial-cluster=instance=https://162.253.55.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.116: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-08-25T19:10:13.612953Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-08-25T19:10:13.612962Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.116:2380"]}
{"level":"info","ts":"2026-08-25T19:10:13.612981Z","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-08-25T19:10:13.613767Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"]}
{"level":"info","ts":"2026-08-25T19:10:13.613834Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.116:2380"],"listen-peer-urls":["https://162.253.55.116:2380"],"advertise-client-urls":["https://162.253.55.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.116: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-08-25T19:10:13.628714Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"14.66181ms"}
{"level":"info","ts":"2026-08-25T19:10:13.67059Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"9755887b76c83964","cluster-id":"5ee78cd75a03071"}
{"level":"info","ts":"2026-08-25T19:10:13.67069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=()"}
{"level":"info","ts":"2026-08-25T19:10:13.670713Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became follower at term 0"}
{"level":"info","ts":"2026-08-25T19:10:13.670749Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 9755887b76c83964 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-08-25T19:10:13.670759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became follower at term 1"}
{"level":"info","ts":"2026-08-25T19:10:13.670851Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=(10904772136602712420)"}
{"level":"warn","ts":"2026-08-25T19:10:13.683319Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-08-25T19:10:13.685977Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-08-25T19:10:13.687867Z","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-08-25T19:10:13.690978Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"9755887b76c83964","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-08-25T19:10:13.691103Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"9755887b76c83964","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-08-25T19:10:13.6914Z","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-08-25T19:10:13.69167Z","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-08-25T19:10:13.691717Z","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-08-25T19:10:13.692278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 switched to configuration voters=(10904772136602712420)"}
{"level":"info","ts":"2026-08-25T19:10:13.692485Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5ee78cd75a03071","local-member-id":"9755887b76c83964","added-peer-id":"9755887b76c83964","added-peer-peer-urls":["https://162.253.55.116:2380"]}
{"level":"info","ts":"2026-08-25T19:10:13.695135Z","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-08-25T19:10:13.695312Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.116:2380"}
{"level":"info","ts":"2026-08-25T19:10:13.69543Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.116:2380"}
{"level":"info","ts":"2026-08-25T19:10:13.695537Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"9755887b76c83964","initial-advertise-peer-urls":["https://162.253.55.116:2380"],"listen-peer-urls":["https://162.253.55.116:2380"],"advertise-client-urls":["https://162.253.55.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-08-25T19:10:13.695626Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-08-25T19:10:14.671548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 is starting a new election at term 1"}
{"level":"info","ts":"2026-08-25T19:10:14.671646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became pre-candidate at term 1"}
{"level":"info","ts":"2026-08-25T19:10:14.671673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 received MsgPreVoteResp from 9755887b76c83964 at term 1"}
{"level":"info","ts":"2026-08-25T19:10:14.67169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became candidate at term 2"}
{"level":"info","ts":"2026-08-25T19:10:14.671697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 received MsgVoteResp from 9755887b76c83964 at term 2"}
{"level":"info","ts":"2026-08-25T19:10:14.671708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"9755887b76c83964 became leader at term 2"}
{"level":"info","ts":"2026-08-25T19:10:14.67172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 9755887b76c83964 elected leader 9755887b76c83964 at term 2"}
{"level":"info","ts":"2026-08-25T19:10:14.672772Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"9755887b76c83964","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.116:2379]}","request-path":"/0/members/9755887b76c83964/attributes","cluster-id":"5ee78cd75a03071","publish-timeout":"7s"}
{"level":"info","ts":"2026-08-25T19:10:14.67279Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-25T19:10:14.672879Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-08-25T19:10:14.672864Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:14.673088Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-08-25T19:10:14.673154Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-08-25T19:10:14.673988Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5ee78cd75a03071","local-member-id":"9755887b76c83964","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:14.674131Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:14.67417Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-08-25T19:10:14.675896Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.116:2379"}
{"level":"info","ts":"2026-08-25T19:10:14.67619Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-08-25T19:10:24.098141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.720097ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4135606530219747878 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" value_size:1678 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-08-25T19:10:24.098298Z","caller":"traceutil/trace.go:171","msg":"trace[413808760] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"436.691823ms","start":"2026-08-25T19:10:23.661583Z","end":"2026-08-25T19:10:24.098274Z","steps":["trace[413808760] 'process raft request'  (duration: 211.235041ms)","trace[413808760] 'compare'  (duration: 224.563823ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:10:24.098388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.661561Z","time spent":"436.795914ms","remote":"127.0.0.1:57194","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-node-lease/kube-root-ca.crt\" value_size:1678 >> failure:<>"}
{"level":"info","ts":"2026-08-25T19:10:24.246244Z","caller":"traceutil/trace.go:171","msg":"trace[1231389371] linearizableReadLoop","detail":"{readStateIndex:362; appliedIndex:359; }","duration":"566.956676ms","start":"2026-08-25T19:10:23.67927Z","end":"2026-08-25T19:10:24.246226Z","steps":["trace[1231389371] 'read index received'  (duration: 193.892358ms)","trace[1231389371] 'applied index is now lower than readState.Index'  (duration: 373.063498ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:24.246285Z","caller":"traceutil/trace.go:171","msg":"trace[775375070] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"578.038312ms","start":"2026-08-25T19:10:23.668233Z","end":"2026-08-25T19:10:24.246272Z","steps":["trace[775375070] 'process raft request'  (duration: 577.93268ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.246447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.143639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"}
{"level":"info","ts":"2026-08-25T19:10:24.246539Z","caller":"traceutil/trace.go:171","msg":"trace[668043999] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:353; }","duration":"567.275533ms","start":"2026-08-25T19:10:23.679244Z","end":"2026-08-25T19:10:24.24652Z","steps":["trace[668043999] 'agreement among raft nodes before linearized reading'  (duration: 567.078299ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.24659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.679236Z","time spent":"567.344534ms","remote":"127.0.0.1:57310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "}
{"level":"warn","ts":"2026-08-25T19:10:24.246696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.668218Z","time spent":"578.122043ms","remote":"127.0.0.1:57284","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4359,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:289 > success:<request_put:<key:\"/registry/minions/instance\" value_size:4325 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"info","ts":"2026-08-25T19:10:24.246968Z","caller":"traceutil/trace.go:171","msg":"trace[1034874402] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"579.541372ms","start":"2026-08-25T19:10:23.666654Z","end":"2026-08-25T19:10:24.246195Z","steps":["trace[1034874402] 'process raft request'  (duration: 559.78476ms)","trace[1034874402] 'compare'  (duration: 19.612689ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:10:24.247042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.666628Z","time spent":"580.381709ms","remote":"127.0.0.1:57158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":754,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/kube-proxy-2fqzg.18cf220eb5c66e30\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/kube-proxy-2fqzg.18cf220eb5c66e30\" value_size:674 lease:4135606530219747270 >> failure:<>"}
{"level":"warn","ts":"2026-08-25T19:10:24.31433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.41004ms","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-08-25T19:10:24.314472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.874675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"}
{"level":"warn","ts":"2026-08-25T19:10:24.314565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.050737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"}
{"level":"info","ts":"2026-08-25T19:10:24.314484Z","caller":"traceutil/trace.go:171","msg":"trace[1656382343] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"212.464646ms","start":"2026-08-25T19:10:24.101963Z","end":"2026-08-25T19:10:24.314427Z","steps":["trace[1656382343] 'process raft request'  (duration: 212.024407ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:24.3146Z","caller":"traceutil/trace.go:171","msg":"trace[675259241] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:354; }","duration":"435.050079ms","start":"2026-08-25T19:10:23.879522Z","end":"2026-08-25T19:10:24.314572Z","steps":["trace[675259241] 'agreement among raft nodes before linearized reading'  (duration: 434.825655ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:24.314615Z","caller":"traceutil/trace.go:171","msg":"trace[2007334436] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:354; }","duration":"485.125479ms","start":"2026-08-25T19:10:23.829472Z","end":"2026-08-25T19:10:24.314598Z","steps":["trace[2007334436] 'agreement among raft nodes before linearized reading'  (duration: 484.909984ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.314528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.574188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-25T19:10:24.314667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.829452Z","time spent":"485.20633ms","remote":"127.0.0.1:57310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "}
{"level":"warn","ts":"2026-08-25T19:10:24.314673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.879502Z","time spent":"435.155401ms","remote":"127.0.0.1:57310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "}
{"level":"warn","ts":"2026-08-25T19:10:24.31434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.019181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"}
{"level":"info","ts":"2026-08-25T19:10:24.314749Z","caller":"traceutil/trace.go:171","msg":"trace[790881319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"322.788722ms","start":"2026-08-25T19:10:23.991897Z","end":"2026-08-25T19:10:24.314685Z","steps":["trace[790881319] 'agreement among raft nodes before linearized reading'  (duration: 322.497357ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:24.314782Z","caller":"traceutil/trace.go:171","msg":"trace[62329693] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:354; }","duration":"385.505871ms","start":"2026-08-25T19:10:23.929258Z","end":"2026-08-25T19:10:24.314764Z","steps":["trace[62329693] 'agreement among raft nodes before linearized reading'  (duration: 384.928359ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.314818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.92923Z","time spent":"385.578852ms","remote":"127.0.0.1:57310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "}
{"level":"warn","ts":"2026-08-25T19:10:24.314416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.104243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-08-25T19:10:24.31487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.991865Z","time spent":"322.933306ms","remote":"127.0.0.1:57382","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-08-25T19:10:24.314894Z","caller":"traceutil/trace.go:171","msg":"trace[523421174] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:354; }","duration":"306.618543ms","start":"2026-08-25T19:10:24.008265Z","end":"2026-08-25T19:10:24.314884Z","steps":["trace[523421174] 'agreement among raft nodes before linearized reading'  (duration: 306.089403ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.314996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:24.008229Z","time spent":"306.751026ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-25T19:10:24.314516Z","caller":"traceutil/trace.go:171","msg":"trace[1987397558] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:354; }","duration":"170.622495ms","start":"2026-08-25T19:10:24.143874Z","end":"2026-08-25T19:10:24.314497Z","steps":["trace[1987397558] 'agreement among raft nodes before linearized reading'  (duration: 170.39461ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.31433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.438773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"}
{"level":"info","ts":"2026-08-25T19:10:24.315118Z","caller":"traceutil/trace.go:171","msg":"trace[1163107941] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:354; }","duration":"535.2812ms","start":"2026-08-25T19:10:23.779825Z","end":"2026-08-25T19:10:24.315106Z","steps":["trace[1163107941] 'agreement among raft nodes before linearized reading'  (duration: 534.384032ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.315156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.779793Z","time spent":"535.354902ms","remote":"127.0.0.1:57310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "}
{"level":"warn","ts":"2026-08-25T19:10:24.314463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.034264ms","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-08-25T19:10:24.315231Z","caller":"traceutil/trace.go:171","msg":"trace[1503439205] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:354; }","duration":"585.983222ms","start":"2026-08-25T19:10:23.729233Z","end":"2026-08-25T19:10:24.315216Z","steps":["trace[1503439205] 'agreement among raft nodes before linearized reading'  (duration: 585.040523ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:24.315294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:23.729212Z","time spent":"586.059494ms","remote":"127.0.0.1:57310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "}
{"level":"info","ts":"2026-08-25T19:10:50.43873Z","caller":"traceutil/trace.go:171","msg":"trace[1787675847] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"111.480841ms","start":"2026-08-25T19:10:50.327227Z","end":"2026-08-25T19:10:50.438708Z","steps":["trace[1787675847] 'process raft request'  (duration: 111.367748ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:50.444381Z","caller":"traceutil/trace.go:171","msg":"trace[1472157697] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"111.45051ms","start":"2026-08-25T19:10:50.332913Z","end":"2026-08-25T19:10:50.444363Z","steps":["trace[1472157697] 'process raft request'  (duration: 111.308166ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:50.44441Z","caller":"traceutil/trace.go:171","msg":"trace[1463608179] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"104.508768ms","start":"2026-08-25T19:10:50.339887Z","end":"2026-08-25T19:10:50.444396Z","steps":["trace[1463608179] 'process raft request'  (duration: 104.408886ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:56.764789Z","caller":"traceutil/trace.go:171","msg":"trace[1693164299] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"186.483038ms","start":"2026-08-25T19:10:56.578277Z","end":"2026-08-25T19:10:56.76476Z","steps":["trace[1693164299] 'process raft request'  (duration: 185.820233ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:56.764928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.174661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6d4l9\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-08-25T19:10:56.764996Z","caller":"traceutil/trace.go:171","msg":"trace[330602060] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6d4l9; range_end:; response_count:1; response_revision:630; }","duration":"159.304644ms","start":"2026-08-25T19:10:56.605677Z","end":"2026-08-25T19:10:56.764982Z","steps":["trace[330602060] 'agreement among raft nodes before linearized reading'  (duration: 159.165971ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:56.764736Z","caller":"traceutil/trace.go:171","msg":"trace[1794732389] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:648; }","duration":"158.974948ms","start":"2026-08-25T19:10:56.605735Z","end":"2026-08-25T19:10:56.76471Z","steps":["trace[1794732389] 'read index received'  (duration: 158.15135ms)","trace[1794732389] 'applied index is now lower than readState.Index'  (duration: 822.548µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:10:57.009411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.259798ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4135606530219748449 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/cilium-6d4l9\" mod_revision:515 > success:<request_put:<key:\"/registry/pods/kube-system/cilium-6d4l9\" value_size:17085 >> failure:<request_range:<key:\"/registry/pods/kube-system/cilium-6d4l9\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-25T19:10:57.009556Z","caller":"traceutil/trace.go:171","msg":"trace[2143064234] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"224.218396ms","start":"2026-08-25T19:10:56.785308Z","end":"2026-08-25T19:10:57.009527Z","steps":["trace[2143064234] 'process raft request'  (duration: 77.742363ms)","trace[2143064234] 'compare'  (duration: 146.030314ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:57.041607Z","caller":"traceutil/trace.go:171","msg":"trace[1363940291] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"160.296525ms","start":"2026-08-25T19:10:56.881283Z","end":"2026-08-25T19:10:57.041579Z","steps":["trace[1363940291] 'read index received'  (duration: 160.167492ms)","trace[1363940291] 'applied index is now lower than readState.Index'  (duration: 128.293µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:57.041653Z","caller":"traceutil/trace.go:171","msg":"trace[698193553] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"220.344798ms","start":"2026-08-25T19:10:56.821279Z","end":"2026-08-25T19:10:57.041624Z","steps":["trace[698193553] 'process raft request'  (duration: 220.189494ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:57.041963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.665822ms","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-08-25T19:10:57.042053Z","caller":"traceutil/trace.go:171","msg":"trace[331397229] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:632; }","duration":"160.802015ms","start":"2026-08-25T19:10:56.88123Z","end":"2026-08-25T19:10:57.042032Z","steps":["trace[331397229] 'agreement among raft nodes before linearized reading'  (duration: 160.490609ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:57.677035Z","caller":"traceutil/trace.go:171","msg":"trace[1580203537] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"214.1348ms","start":"2026-08-25T19:10:57.462857Z","end":"2026-08-25T19:10:57.676992Z","steps":["trace[1580203537] 'process raft request'  (duration: 206.498906ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:57.984569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.129155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.116\" ","response":"range_response_count:1 size:135"}
{"level":"info","ts":"2026-08-25T19:10:57.984658Z","caller":"traceutil/trace.go:171","msg":"trace[2118371349] range","detail":"{range_begin:/registry/masterleases/162.253.55.116; range_end:; response_count:1; response_revision:635; }","duration":"255.285148ms","start":"2026-08-25T19:10:57.729352Z","end":"2026-08-25T19:10:57.984637Z","steps":["trace[2118371349] 'range keys from in-memory index tree'  (duration: 254.914591ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:58.247291Z","caller":"traceutil/trace.go:171","msg":"trace[603704752] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:654; }","duration":"494.47998ms","start":"2026-08-25T19:10:57.752788Z","end":"2026-08-25T19:10:58.247268Z","steps":["trace[603704752] 'read index received'  (duration: 494.354037ms)","trace[603704752] 'applied index is now lower than readState.Index'  (duration: 125.003µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:58.247346Z","caller":"traceutil/trace.go:171","msg":"trace[1250771537] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"513.476436ms","start":"2026-08-25T19:10:57.733838Z","end":"2026-08-25T19:10:58.247315Z","steps":["trace[1250771537] 'process raft request'  (duration: 513.298202ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.24742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.623532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:10:58.247454Z","caller":"traceutil/trace.go:171","msg":"trace[202840027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"494.703934ms","start":"2026-08-25T19:10:57.752741Z","end":"2026-08-25T19:10:58.247445Z","steps":["trace[202840027] 'agreement among raft nodes before linearized reading'  (duration: 494.616013ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.247485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:57.75272Z","time spent":"494.757755ms","remote":"127.0.0.1:57076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2026-08-25T19:10:58.247491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:57.73382Z","time spent":"513.603809ms","remote":"127.0.0.1:57354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" mod_revision:0 > success:<request_put:<key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" value_size:2525 >> failure:<>"}
{"level":"warn","ts":"2026-08-25T19:10:58.369564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:57.985647Z","time spent":"383.908947ms","remote":"127.0.0.1:57122","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""}
{"level":"warn","ts":"2026-08-25T19:10:58.369729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.320522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:10:58.369783Z","caller":"traceutil/trace.go:171","msg":"trace[796712385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"121.411233ms","start":"2026-08-25T19:10:58.24836Z","end":"2026-08-25T19:10:58.369772Z","steps":["trace[796712385] 'agreement among raft nodes before linearized reading'  (duration: 121.318541ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:58.369948Z","caller":"traceutil/trace.go:171","msg":"trace[1388128339] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"120.935113ms","start":"2026-08-25T19:10:58.248402Z","end":"2026-08-25T19:10:58.369337Z","steps":["trace[1388128339] 'read index received'  (duration: 73.686281ms)","trace[1388128339] 'applied index is now lower than readState.Index'  (duration: 47.247252ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:10:58.370241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.755689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"}
{"level":"info","ts":"2026-08-25T19:10:58.370303Z","caller":"traceutil/trace.go:171","msg":"trace[777394826] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:636; }","duration":"119.865151ms","start":"2026-08-25T19:10:58.25042Z","end":"2026-08-25T19:10:58.370285Z","steps":["trace[777394826] 'agreement among raft nodes before linearized reading'  (duration: 119.730168ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:58.912578Z","caller":"traceutil/trace.go:171","msg":"trace[1431123764] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"385.938639ms","start":"2026-08-25T19:10:58.526611Z","end":"2026-08-25T19:10:58.912549Z","steps":["trace[1431123764] 'read index received'  (duration: 385.883218ms)","trace[1431123764] 'applied index is now lower than readState.Index'  (duration: 53.941µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:10:58.912719Z","caller":"traceutil/trace.go:171","msg":"trace[275775366] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"508.063626ms","start":"2026-08-25T19:10:58.404607Z","end":"2026-08-25T19:10:58.912671Z","steps":["trace[275775366] 'process raft request'  (duration: 507.824942ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.912874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.250246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"warn","ts":"2026-08-25T19:10:58.9129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.881327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-08-25T19:10:58.91289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:58.404582Z","time spent":"508.23065ms","remote":"127.0.0.1:57300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rbgjc\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-rbgjc\" value_size:2651 >> failure:<>"}
{"level":"info","ts":"2026-08-25T19:10:58.912932Z","caller":"traceutil/trace.go:171","msg":"trace[107596907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"386.354477ms","start":"2026-08-25T19:10:58.526565Z","end":"2026-08-25T19:10:58.91292Z","steps":["trace[107596907] 'agreement among raft nodes before linearized reading'  (duration: 386.120402ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.912937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.325321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-08-25T19:10:58.912973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:58.526547Z","time spent":"386.417329ms","remote":"127.0.0.1:57382","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-08-25T19:10:58.912988Z","caller":"traceutil/trace.go:171","msg":"trace[637199118] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"159.985429ms","start":"2026-08-25T19:10:58.752959Z","end":"2026-08-25T19:10:58.912945Z","steps":["trace[637199118] 'agreement among raft nodes before linearized reading'  (duration: 159.861846ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:10:58.91301Z","caller":"traceutil/trace.go:171","msg":"trace[1487849315] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"368.418173ms","start":"2026-08-25T19:10:58.544569Z","end":"2026-08-25T19:10:58.912987Z","steps":["trace[1487849315] 'agreement among raft nodes before linearized reading'  (duration: 368.178077ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.913027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.364762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"}
{"level":"warn","ts":"2026-08-25T19:10:58.913058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:58.544557Z","time spent":"368.488395ms","remote":"127.0.0.1:57382","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-08-25T19:10:58.913108Z","caller":"traceutil/trace.go:171","msg":"trace[1395890758] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"368.461784ms","start":"2026-08-25T19:10:58.544623Z","end":"2026-08-25T19:10:58.913085Z","steps":["trace[1395890758] 'agreement among raft nodes before linearized reading'  (duration: 368.223839ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:10:58.913151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:10:58.544617Z","time spent":"368.523625ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "}
{"level":"info","ts":"2026-08-25T19:12:11.149118Z","caller":"traceutil/trace.go:171","msg":"trace[364455528] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"244.300562ms","start":"2026-08-25T19:12:10.904783Z","end":"2026-08-25T19:12:11.149084Z","steps":["trace[364455528] 'process raft request'  (duration: 244.082657ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:28.518331Z","caller":"traceutil/trace.go:171","msg":"trace[178962030] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"188.549868ms","start":"2026-08-25T19:13:28.329755Z","end":"2026-08-25T19:13:28.518305Z","steps":["trace[178962030] 'process raft request'  (duration: 188.365525ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:13:28.668919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.259901ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4135606530219751342 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2008 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-25T19:13:28.669062Z","caller":"traceutil/trace.go:171","msg":"trace[1130102838] linearizableReadLoop","detail":"{readStateIndex:2113; appliedIndex:2112; }","duration":"145.811778ms","start":"2026-08-25T19:13:28.52323Z","end":"2026-08-25T19:13:28.669041Z","steps":["trace[1130102838] 'read index received'  (duration: 44.333323ms)","trace[1130102838] 'applied index is now lower than readState.Index'  (duration: 101.476775ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:13:28.669174Z","caller":"traceutil/trace.go:171","msg":"trace[1819959101] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"322.326671ms","start":"2026-08-25T19:13:28.346778Z","end":"2026-08-25T19:13:28.669104Z","steps":["trace[1819959101] 'process raft request'  (duration: 220.765624ms)","trace[1819959101] 'compare'  (duration: 101.080178ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:13:28.669234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.018033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9bc2a36a-698c-42bf-8e6c-9bd5f7578317\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-08-25T19:13:28.669429Z","caller":"traceutil/trace.go:171","msg":"trace[1934389588] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9bc2a36a-698c-42bf-8e6c-9bd5f7578317; range_end:; response_count:1; response_revision:2034; }","duration":"146.208117ms","start":"2026-08-25T19:13:28.523203Z","end":"2026-08-25T19:13:28.669411Z","steps":["trace[1934389588] 'agreement among raft nodes before linearized reading'  (duration: 145.891ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:13:28.669515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:13:28.346769Z","time spent":"322.550616ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2008 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"info","ts":"2026-08-25T19:13:28.693282Z","caller":"traceutil/trace.go:171","msg":"trace[1666431619] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"167.300844ms","start":"2026-08-25T19:13:28.525924Z","end":"2026-08-25T19:13:28.693225Z","steps":["trace[1666431619] 'process raft request'  (duration: 166.951257ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:28.693326Z","caller":"traceutil/trace.go:171","msg":"trace[265382427] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"167.124502ms","start":"2026-08-25T19:13:28.526161Z","end":"2026-08-25T19:13:28.693285Z","steps":["trace[265382427] 'process raft request'  (duration: 166.963618ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:28.693745Z","caller":"traceutil/trace.go:171","msg":"trace[1188909611] transaction","detail":"{read_only:false; response_revision:2038; number_of_response:1; }","duration":"166.52576ms","start":"2026-08-25T19:13:28.52719Z","end":"2026-08-25T19:13:28.693716Z","steps":["trace[1188909611] 'process raft request'  (duration: 166.333126ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:28.693828Z","caller":"traceutil/trace.go:171","msg":"trace[69546328] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"167.273465ms","start":"2026-08-25T19:13:28.526487Z","end":"2026-08-25T19:13:28.693761Z","steps":["trace[69546328] 'process raft request'  (duration: 166.706273ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:45.451902Z","caller":"traceutil/trace.go:171","msg":"trace[1939077162] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"123.175308ms","start":"2026-08-25T19:13:45.328701Z","end":"2026-08-25T19:13:45.451876Z","steps":["trace[1939077162] 'process raft request'  (duration: 123.027035ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:13:45.535185Z","caller":"traceutil/trace.go:171","msg":"trace[1739864141] linearizableReadLoop","detail":"{readStateIndex:2257; appliedIndex:2256; }","duration":"104.220431ms","start":"2026-08-25T19:13:45.430935Z","end":"2026-08-25T19:13:45.535155Z","steps":["trace[1739864141] 'read index received'  (duration: 21.166441ms)","trace[1739864141] 'applied index is now lower than readState.Index'  (duration: 83.05239ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:13:45.535309Z","caller":"traceutil/trace.go:171","msg":"trace[1194385535] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"105.698812ms","start":"2026-08-25T19:13:45.429585Z","end":"2026-08-25T19:13:45.535283Z","steps":["trace[1194385535] 'process raft request'  (duration: 105.375654ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:13:45.535427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.474157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"}
{"level":"info","ts":"2026-08-25T19:13:45.535508Z","caller":"traceutil/trace.go:171","msg":"trace[1093603761] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2175; }","duration":"104.62491ms","start":"2026-08-25T19:13:45.430869Z","end":"2026-08-25T19:13:45.535494Z","steps":["trace[1093603761] 'agreement among raft nodes before linearized reading'  (duration: 104.406926ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:17.757426Z","caller":"traceutil/trace.go:171","msg":"trace[252344920] transaction","detail":"{read_only:false; response_revision:2353; number_of_response:1; }","duration":"102.503557ms","start":"2026-08-25T19:14:17.654895Z","end":"2026-08-25T19:14:17.757399Z","steps":["trace[252344920] 'process raft request'  (duration: 99.325352ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:17.772706Z","caller":"traceutil/trace.go:171","msg":"trace[38060719] transaction","detail":"{read_only:false; response_revision:2354; number_of_response:1; }","duration":"117.611644ms","start":"2026-08-25T19:14:17.655082Z","end":"2026-08-25T19:14:17.772694Z","steps":["trace[38060719] 'process raft request'  (duration: 117.39686ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:23.878639Z","caller":"traceutil/trace.go:171","msg":"trace[1892911624] transaction","detail":"{read_only:false; response_revision:2385; number_of_response:1; }","duration":"103.566859ms","start":"2026-08-25T19:14:23.775043Z","end":"2026-08-25T19:14:23.878609Z","steps":["trace[1892911624] 'process raft request'  (duration: 103.372695ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:23.905799Z","caller":"traceutil/trace.go:171","msg":"trace[3089276] linearizableReadLoop","detail":"{readStateIndex:2477; appliedIndex:2475; }","duration":"107.962279ms","start":"2026-08-25T19:14:23.797785Z","end":"2026-08-25T19:14:23.905747Z","steps":["trace[3089276] 'read index received'  (duration: 80.566281ms)","trace[3089276] 'applied index is now lower than readState.Index'  (duration: 27.395088ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:14:23.905986Z","caller":"traceutil/trace.go:171","msg":"trace[2097809069] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"111.890788ms","start":"2026-08-25T19:14:23.794063Z","end":"2026-08-25T19:14:23.905954Z","steps":["trace[2097809069] 'process raft request'  (duration: 111.539861ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:14:23.906015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.195223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-08-25T19:14:23.906427Z","caller":"traceutil/trace.go:171","msg":"trace[975629975] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2386; }","duration":"108.682083ms","start":"2026-08-25T19:14:23.797728Z","end":"2026-08-25T19:14:23.906411Z","steps":["trace[975629975] 'agreement among raft nodes before linearized reading'  (duration: 108.197423ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:14:24.27297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.790634ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4135606530219752148 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2377 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:464 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-08-25T19:14:24.273226Z","caller":"traceutil/trace.go:171","msg":"trace[683262211] linearizableReadLoop","detail":"{readStateIndex:2478; appliedIndex:2477; }","duration":"116.546563ms","start":"2026-08-25T19:14:24.156654Z","end":"2026-08-25T19:14:24.2732Z","steps":["trace[683262211] 'read index received'  (duration: 8.347261ms)","trace[683262211] 'applied index is now lower than readState.Index'  (duration: 108.197422ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:14:24.273398Z","caller":"traceutil/trace.go:171","msg":"trace[120405943] transaction","detail":"{read_only:false; response_revision:2387; number_of_response:1; }","duration":"192.282565ms","start":"2026-08-25T19:14:24.081094Z","end":"2026-08-25T19:14:24.273377Z","steps":["trace[120405943] 'process raft request'  (duration: 83.96478ms)","trace[120405943] 'compare'  (duration: 107.667702ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:14:24.273937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.282717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-08-25T19:14:24.274063Z","caller":"traceutil/trace.go:171","msg":"trace[779970652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2387; }","duration":"117.444131ms","start":"2026-08-25T19:14:24.156595Z","end":"2026-08-25T19:14:24.274039Z","steps":["trace[779970652] 'agreement among raft nodes before linearized reading'  (duration: 117.113414ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:14:24.273918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.135672ms","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-08-25T19:14:24.274269Z","caller":"traceutil/trace.go:171","msg":"trace[1083000694] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2387; }","duration":"110.729303ms","start":"2026-08-25T19:14:24.163479Z","end":"2026-08-25T19:14:24.274209Z","steps":["trace[1083000694] 'agreement among raft nodes before linearized reading'  (duration: 109.981498ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:24.430327Z","caller":"traceutil/trace.go:171","msg":"trace[149886427] transaction","detail":"{read_only:false; response_revision:2388; number_of_response:1; }","duration":"149.962973ms","start":"2026-08-25T19:14:24.279941Z","end":"2026-08-25T19:14:24.429904Z","steps":["trace[149886427] 'process raft request'  (duration: 129.338253ms)","trace[149886427] 'compare'  (duration: 20.434636ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:14:24.432356Z","caller":"traceutil/trace.go:171","msg":"trace[459222621] transaction","detail":"{read_only:false; response_revision:2390; number_of_response:1; }","duration":"152.313582ms","start":"2026-08-25T19:14:24.280011Z","end":"2026-08-25T19:14:24.432324Z","steps":["trace[459222621] 'process raft request'  (duration: 152.179668ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:24.432652Z","caller":"traceutil/trace.go:171","msg":"trace[1931136935] transaction","detail":"{read_only:false; response_revision:2389; number_of_response:1; }","duration":"152.680228ms","start":"2026-08-25T19:14:24.279964Z","end":"2026-08-25T19:14:24.432645Z","steps":["trace[1931136935] 'process raft request'  (duration: 152.055004ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:14:24.4328Z","caller":"traceutil/trace.go:171","msg":"trace[1101444201] transaction","detail":"{read_only:false; response_revision:2391; number_of_response:1; }","duration":"152.284501ms","start":"2026-08-25T19:14:24.280447Z","end":"2026-08-25T19:14:24.432732Z","steps":["trace[1101444201] 'process raft request'  (duration: 151.842372ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:14:58.887134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.223705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:14:58.887246Z","caller":"traceutil/trace.go:171","msg":"trace[97744261] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2752; }","duration":"133.410068ms","start":"2026-08-25T19:14:58.753813Z","end":"2026-08-25T19:14:58.887223Z","steps":["trace[97744261] 'range keys from in-memory index tree'  (duration: 133.078172ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:15:32.331011Z","caller":"traceutil/trace.go:171","msg":"trace[1213605573] transaction","detail":"{read_only:false; response_revision:2954; number_of_response:1; }","duration":"127.173981ms","start":"2026-08-25T19:15:32.203805Z","end":"2026-08-25T19:15:32.330979Z","steps":["trace[1213605573] 'process raft request'  (duration: 126.896945ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:15:32.347232Z","caller":"traceutil/trace.go:171","msg":"trace[1893178650] transaction","detail":"{read_only:false; response_revision:2955; number_of_response:1; }","duration":"142.659626ms","start":"2026-08-25T19:15:32.204543Z","end":"2026-08-25T19:15:32.347203Z","steps":["trace[1893178650] 'process raft request'  (duration: 142.486142ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:15:32.879643Z","caller":"traceutil/trace.go:171","msg":"trace[68905648] linearizableReadLoop","detail":"{readStateIndex:3069; appliedIndex:3068; }","duration":"127.350803ms","start":"2026-08-25T19:15:32.752264Z","end":"2026-08-25T19:15:32.879615Z","steps":["trace[68905648] 'read index received'  (duration: 127.18569ms)","trace[68905648] 'applied index is now lower than readState.Index'  (duration: 163.543µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:15:32.879711Z","caller":"traceutil/trace.go:171","msg":"trace[1505981308] transaction","detail":"{read_only:false; response_revision:2957; number_of_response:1; }","duration":"159.51298ms","start":"2026-08-25T19:15:32.720139Z","end":"2026-08-25T19:15:32.879652Z","steps":["trace[1505981308] 'process raft request'  (duration: 159.294806ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:15:32.879889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.602459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:15:32.879997Z","caller":"traceutil/trace.go:171","msg":"trace[1584296675] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2957; }","duration":"127.768692ms","start":"2026-08-25T19:15:32.752202Z","end":"2026-08-25T19:15:32.87997Z","steps":["trace[1584296675] 'agreement among raft nodes before linearized reading'  (duration: 127.528878ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:15:38.473798Z","caller":"traceutil/trace.go:171","msg":"trace[267173476] transaction","detail":"{read_only:false; response_revision:2989; number_of_response:1; }","duration":"107.138852ms","start":"2026-08-25T19:15:38.366627Z","end":"2026-08-25T19:15:38.473766Z","steps":["trace[267173476] 'process raft request'  (duration: 71.822473ms)","trace[267173476] 'compare'  (duration: 35.151276ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:19:42.587622Z","caller":"traceutil/trace.go:171","msg":"trace[67026995] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"151.318546ms","start":"2026-08-25T19:19:42.436265Z","end":"2026-08-25T19:19:42.587584Z","steps":["trace[67026995] 'process raft request'  (duration: 151.01973ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:42.599612Z","caller":"traceutil/trace.go:171","msg":"trace[1452416429] linearizableReadLoop","detail":"{readStateIndex:5155; appliedIndex:5153; }","duration":"159.239168ms","start":"2026-08-25T19:19:42.440341Z","end":"2026-08-25T19:19:42.59958Z","steps":["trace[1452416429] 'read index received'  (duration: 146.934408ms)","trace[1452416429] 'applied index is now lower than readState.Index'  (duration: 12.30352ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:19:42.599761Z","caller":"traceutil/trace.go:171","msg":"trace[422863399] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"160.899992ms","start":"2026-08-25T19:19:42.438813Z","end":"2026-08-25T19:19:42.599713Z","steps":["trace[422863399] 'process raft request'  (duration: 160.606606ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:42.599967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.588495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"}
{"level":"info","ts":"2026-08-25T19:19:42.600066Z","caller":"traceutil/trace.go:171","msg":"trace[1428273385] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4966; }","duration":"159.734317ms","start":"2026-08-25T19:19:42.440312Z","end":"2026-08-25T19:19:42.600047Z","steps":["trace[1428273385] 'agreement among raft nodes before linearized reading'  (duration: 159.429041ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:42.601193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.712514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:49 size:1957116"}
{"level":"info","ts":"2026-08-25T19:19:42.601327Z","caller":"traceutil/trace.go:171","msg":"trace[285149471] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:49; response_revision:4966; }","duration":"119.904398ms","start":"2026-08-25T19:19:42.481404Z","end":"2026-08-25T19:19:42.601308Z","steps":["trace[285149471] 'agreement among raft nodes before linearized reading'  (duration: 118.504109ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:51.617859Z","caller":"traceutil/trace.go:171","msg":"trace[1298952968] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"312.784179ms","start":"2026-08-25T19:19:51.305022Z","end":"2026-08-25T19:19:51.617806Z","steps":["trace[1298952968] 'process raft request'  (duration: 312.476012ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:51.61809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:19:51.304947Z","time spent":"313.031755ms","remote":"127.0.0.1:57184","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58202,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/monitoring/sh.helm.release.v1.vector.v1\" value_size:58135 >> failure:<>"}
{"level":"warn","ts":"2026-08-25T19:19:51.618117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.139454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cfc83c5b-4fed-4617-a751-670e3771d32f\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-08-25T19:19:51.618185Z","caller":"traceutil/trace.go:171","msg":"trace[674203270] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cfc83c5b-4fed-4617-a751-670e3771d32f; range_end:; response_count:1; response_revision:5241; }","duration":"243.288827ms","start":"2026-08-25T19:19:51.374879Z","end":"2026-08-25T19:19:51.618168Z","steps":["trace[674203270] 'agreement among raft nodes before linearized reading'  (duration: 243.016141ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:51.617763Z","caller":"traceutil/trace.go:171","msg":"trace[125676347] linearizableReadLoop","detail":"{readStateIndex:5441; appliedIndex:5440; }","duration":"242.781766ms","start":"2026-08-25T19:19:51.37495Z","end":"2026-08-25T19:19:51.617732Z","steps":["trace[125676347] 'read index received'  (duration: 242.547731ms)","trace[125676347] 'applied index is now lower than readState.Index'  (duration: 232.655µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:19:51.690122Z","caller":"traceutil/trace.go:171","msg":"trace[837159139] transaction","detail":"{read_only:false; response_revision:5242; number_of_response:1; }","duration":"301.99482ms","start":"2026-08-25T19:19:51.3881Z","end":"2026-08-25T19:19:51.690095Z","steps":["trace[837159139] 'process raft request'  (duration: 301.728094ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:51.690312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:19:51.388062Z","time spent":"302.160364ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5211 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-08-25T19:19:51.690658Z","caller":"traceutil/trace.go:171","msg":"trace[1910444836] transaction","detail":"{read_only:false; response_revision:5243; number_of_response:1; }","duration":"181.998491ms","start":"2026-08-25T19:19:51.508649Z","end":"2026-08-25T19:19:51.690647Z","steps":["trace[1910444836] 'process raft request'  (duration: 181.328986ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:51.690786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.800911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:19:51.690818Z","caller":"traceutil/trace.go:171","msg":"trace[1511421806] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:5244; }","duration":"253.858262ms","start":"2026-08-25T19:19:51.436949Z","end":"2026-08-25T19:19:51.690807Z","steps":["trace[1511421806] 'agreement among raft nodes before linearized reading'  (duration: 253.797431ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:51.690984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.725162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-hz757-tls\" ","response":"range_response_count:1 size:2184"}
{"level":"info","ts":"2026-08-25T19:19:51.691079Z","caller":"traceutil/trace.go:171","msg":"trace[145872163] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/kube-prometheus-stack-prometheus-node-exporter-hz757-tls; range_end:; response_count:1; response_revision:5244; }","duration":"261.871955ms","start":"2026-08-25T19:19:51.429184Z","end":"2026-08-25T19:19:51.691056Z","steps":["trace[145872163] 'agreement among raft nodes before linearized reading'  (duration: 261.566289ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:51.691153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.123095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-cfc83c5b-4fed-4617-a751-670e3771d32f\" ","response":"range_response_count:1 size:3601"}
{"level":"info","ts":"2026-08-25T19:19:51.691186Z","caller":"traceutil/trace.go:171","msg":"trace[192938874] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-cfc83c5b-4fed-4617-a751-670e3771d32f; range_end:; response_count:1; response_revision:5244; }","duration":"186.206706ms","start":"2026-08-25T19:19:51.504968Z","end":"2026-08-25T19:19:51.691175Z","steps":["trace[192938874] 'agreement among raft nodes before linearized reading'  (duration: 186.082374ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:19:51.691355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.735223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeaturerules/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeaturerules0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:19:51.691395Z","caller":"traceutil/trace.go:171","msg":"trace[1298285199] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeaturerules/; range_end:/registry/nfd.k8s-sigs.io/nodefeaturerules0; response_count:0; response_revision:5244; }","duration":"204.775583ms","start":"2026-08-25T19:19:51.486609Z","end":"2026-08-25T19:19:51.691384Z","steps":["trace[1298285199] 'agreement among raft nodes before linearized reading'  (duration: 204.714322ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:51.691026Z","caller":"traceutil/trace.go:171","msg":"trace[1562971512] transaction","detail":"{read_only:false; response_revision:5244; number_of_response:1; }","duration":"123.691116ms","start":"2026-08-25T19:19:51.56732Z","end":"2026-08-25T19:19:51.691011Z","steps":["trace[1562971512] 'process raft request'  (duration: 122.699575ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:52.027691Z","caller":"traceutil/trace.go:171","msg":"trace[1776625739] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"149.291305ms","start":"2026-08-25T19:19:51.878363Z","end":"2026-08-25T19:19:52.027654Z","steps":["trace[1776625739] 'process raft request'  (duration: 149.06843ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:19:52.040901Z","caller":"traceutil/trace.go:171","msg":"trace[847528480] transaction","detail":"{read_only:false; response_revision:5258; number_of_response:1; }","duration":"115.285445ms","start":"2026-08-25T19:19:51.925588Z","end":"2026-08-25T19:19:52.040874Z","steps":["trace[847528480] 'process raft request'  (duration: 115.163571ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:05.921811Z","caller":"traceutil/trace.go:171","msg":"trace[1252297413] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"106.23942ms","start":"2026-08-25T19:20:05.81555Z","end":"2026-08-25T19:20:05.921789Z","steps":["trace[1252297413] 'process raft request'  (duration: 106.124417ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:06.511359Z","caller":"traceutil/trace.go:171","msg":"trace[2011629237] transaction","detail":"{read_only:false; response_revision:5509; number_of_response:1; }","duration":"169.063237ms","start":"2026-08-25T19:20:06.342259Z","end":"2026-08-25T19:20:06.511323Z","steps":["trace[2011629237] 'process raft request'  (duration: 168.832132ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:06.839288Z","caller":"traceutil/trace.go:171","msg":"trace[46928894] transaction","detail":"{read_only:false; response_revision:5511; number_of_response:1; }","duration":"321.431526ms","start":"2026-08-25T19:20:06.517832Z","end":"2026-08-25T19:20:06.839264Z","steps":["trace[46928894] 'process raft request'  (duration: 321.309543ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:06.839372Z","caller":"traceutil/trace.go:171","msg":"trace[690692077] transaction","detail":"{read_only:false; response_revision:5510; number_of_response:1; }","duration":"322.323144ms","start":"2026-08-25T19:20:06.517001Z","end":"2026-08-25T19:20:06.839324Z","steps":["trace[690692077] 'process raft request'  (duration: 277.531633ms)","trace[690692077] 'compare'  (duration: 44.419963ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:20:06.839434Z","caller":"traceutil/trace.go:171","msg":"trace[623221970] linearizableReadLoop","detail":"{readStateIndex:5721; appliedIndex:5717; }","duration":"164.250908ms","start":"2026-08-25T19:20:06.675154Z","end":"2026-08-25T19:20:06.839405Z","steps":["trace[623221970] 'read index received'  (duration: 119.402177ms)","trace[623221970] 'applied index is now lower than readState.Index'  (duration: 44.847771ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:20:06.839516Z","caller":"traceutil/trace.go:171","msg":"trace[674079237] transaction","detail":"{read_only:false; response_revision:5512; number_of_response:1; }","duration":"321.499156ms","start":"2026-08-25T19:20:06.517961Z","end":"2026-08-25T19:20:06.83946Z","steps":["trace[674079237] 'process raft request'  (duration: 321.236631ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:20:06.839594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:20:06.516965Z","time spent":"322.507337ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:5469 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-08-25T19:20:06.83958Z","caller":"traceutil/trace.go:171","msg":"trace[1399805798] transaction","detail":"{read_only:false; response_revision:5513; number_of_response:1; }","duration":"320.123818ms","start":"2026-08-25T19:20:06.519386Z","end":"2026-08-25T19:20:06.83951Z","steps":["trace[1399805798] 'process raft request'  (duration: 319.920704ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:20:06.839697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:20:06.517797Z","time spent":"321.586749ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5468 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:368 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-08-25T19:20:06.839745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.487773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1990"}
{"level":"info","ts":"2026-08-25T19:20:06.839794Z","caller":"traceutil/trace.go:171","msg":"trace[1009827597] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:5513; }","duration":"161.585995ms","start":"2026-08-25T19:20:06.678188Z","end":"2026-08-25T19:20:06.839774Z","steps":["trace[1009827597] 'agreement among raft nodes before linearized reading'  (duration: 161.388991ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:20:06.839825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:20:06.519371Z","time spent":"320.330612ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:5466 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-08-25T19:20:06.839844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:20:06.517931Z","time spent":"321.717971ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:5467 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"warn","ts":"2026-08-25T19:20:06.839854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.696919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-v7gjt\" ","response":"range_response_count:1 size:7818"}
{"level":"info","ts":"2026-08-25T19:20:06.840035Z","caller":"traceutil/trace.go:171","msg":"trace[920194671] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-v7gjt; range_end:; response_count:1; response_revision:5513; }","duration":"164.916773ms","start":"2026-08-25T19:20:06.675092Z","end":"2026-08-25T19:20:06.840009Z","steps":["trace[920194671] 'agreement among raft nodes before linearized reading'  (duration: 164.451624ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:14.740058Z","caller":"traceutil/trace.go:171","msg":"trace[193798154] transaction","detail":"{read_only:false; response_revision:5712; number_of_response:1; }","duration":"198.985965ms","start":"2026-08-25T19:20:14.541028Z","end":"2026-08-25T19:20:14.740014Z","steps":["trace[193798154] 'process raft request'  (duration: 198.693179ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:14.825242Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2857}
{"level":"info","ts":"2026-08-25T19:20:14.988325Z","caller":"traceutil/trace.go:171","msg":"trace[475345117] linearizableReadLoop","detail":"{readStateIndex:5929; appliedIndex:5928; }","duration":"149.365456ms","start":"2026-08-25T19:20:14.838928Z","end":"2026-08-25T19:20:14.988294Z","steps":["trace[475345117] 'read index received'  (duration: 122.944199ms)","trace[475345117] 'applied index is now lower than readState.Index'  (duration: 26.420057ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:20:14.98846Z","caller":"traceutil/trace.go:171","msg":"trace[1086908810] transaction","detail":"{read_only:false; response_revision:5715; number_of_response:1; }","duration":"153.915659ms","start":"2026-08-25T19:20:14.834486Z","end":"2026-08-25T19:20:14.988402Z","steps":["trace[1086908810] 'process raft request'  (duration: 127.406551ms)","trace[1086908810] 'compare'  (duration: 11.548455ms)","trace[1086908810] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/pods/local-path-storage/helper-pod-create-pvc-0823ecd4-4c91-4721-bc5e-affb8926e95a; req_size:3745; } (duration: 14.719799ms)"],"step_count":3}
{"level":"warn","ts":"2026-08-25T19:20:14.988669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.629999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"warn","ts":"2026-08-25T19:20:14.988643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.690913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"}
{"level":"warn","ts":"2026-08-25T19:20:14.988722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.887393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"}
{"level":"info","ts":"2026-08-25T19:20:14.988767Z","caller":"traceutil/trace.go:171","msg":"trace[334137931] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5715; }","duration":"105.970845ms","start":"2026-08-25T19:20:14.882788Z","end":"2026-08-25T19:20:14.988759Z","steps":["trace[334137931] 'agreement among raft nodes before linearized reading'  (duration: 105.797911ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:14.988762Z","caller":"traceutil/trace.go:171","msg":"trace[1409067870] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5715; }","duration":"149.859876ms","start":"2026-08-25T19:20:14.838877Z","end":"2026-08-25T19:20:14.988737Z","steps":["trace[1409067870] 'agreement among raft nodes before linearized reading'  (duration: 149.5507ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:20:14.988811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.838882ms","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-08-25T19:20:14.988846Z","caller":"traceutil/trace.go:171","msg":"trace[1569836251] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5715; }","duration":"106.926964ms","start":"2026-08-25T19:20:14.881908Z","end":"2026-08-25T19:20:14.988835Z","steps":["trace[1569836251] 'agreement among raft nodes before linearized reading'  (duration: 106.840552ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:14.988728Z","caller":"traceutil/trace.go:171","msg":"trace[25958851] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5715; }","duration":"109.778372ms","start":"2026-08-25T19:20:14.878935Z","end":"2026-08-25T19:20:14.988713Z","steps":["trace[25958851] 'agreement among raft nodes before linearized reading'  (duration: 109.545757ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:20:14.98997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.378024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-08-25T19:20:14.990095Z","caller":"traceutil/trace.go:171","msg":"trace[611746103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5715; }","duration":"108.572868ms","start":"2026-08-25T19:20:14.881493Z","end":"2026-08-25T19:20:14.990065Z","steps":["trace[611746103] 'agreement among raft nodes before linearized reading'  (duration: 107.320912ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:20:15.037079Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2857,"took":"209.507889ms","hash":3627409947,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":32411648,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-25T19:20:15.03717Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3627409947,"revision":2857,"compact-revision":-1}
{"level":"info","ts":"2026-08-25T19:25:14.83245Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5714}
{"level":"info","ts":"2026-08-25T19:25:14.917158Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5714,"took":"82.403434ms","hash":614490404,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":26996736,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-08-25T19:25:14.917222Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":614490404,"revision":5714,"compact-revision":2857}
{"level":"warn","ts":"2026-08-25T19:26:41.964889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.662353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:26:41.964974Z","caller":"traceutil/trace.go:171","msg":"trace[479089969] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:8626; }","duration":"280.822676ms","start":"2026-08-25T19:26:41.684134Z","end":"2026-08-25T19:26:41.964957Z","steps":["trace[479089969] 'count revisions from in-memory index tree'  (duration: 280.53421ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:26:52.965173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.464314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:26:52.965325Z","caller":"traceutil/trace.go:171","msg":"trace[1880325971] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8683; }","duration":"211.701258ms","start":"2026-08-25T19:26:52.753598Z","end":"2026-08-25T19:26:52.965299Z","steps":["trace[1880325971] 'range keys from in-memory index tree'  (duration: 211.31951ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:26:53.941965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.617789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:26:53.942068Z","caller":"traceutil/trace.go:171","msg":"trace[1637444287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8690; }","duration":"187.805773ms","start":"2026-08-25T19:26:53.754242Z","end":"2026-08-25T19:26:53.942048Z","steps":["trace[1637444287] 'range keys from in-memory index tree'  (duration: 187.434495ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:27:18.715687Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023d9.wal"}
{"level":"warn","ts":"2026-08-25T19:27:26.876717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.767459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:27:26.876864Z","caller":"traceutil/trace.go:171","msg":"trace[1234645774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8917; }","duration":"122.971532ms","start":"2026-08-25T19:27:26.753863Z","end":"2026-08-25T19:27:26.876835Z","steps":["trace[1234645774] 'range keys from in-memory index tree'  (duration: 122.655986ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:27:36.253281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.629891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"}
{"level":"info","ts":"2026-08-25T19:27:36.253357Z","caller":"traceutil/trace.go:171","msg":"trace[1883279304] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8969; }","duration":"195.765233ms","start":"2026-08-25T19:27:36.057576Z","end":"2026-08-25T19:27:36.253341Z","steps":["trace[1883279304] 'range keys from in-memory index tree'  (duration: 195.434307ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:28:39.440052Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9755887b76c83964","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-25T19:28:39.446936Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001}
{"level":"info","ts":"2026-08-25T19:28:39.44708Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001}
{"level":"info","ts":"2026-08-25T19:29:00.433281Z","caller":"traceutil/trace.go:171","msg":"trace[788868803] transaction","detail":"{read_only:false; response_revision:9802; number_of_response:1; }","duration":"136.016377ms","start":"2026-08-25T19:29:00.297227Z","end":"2026-08-25T19:29:00.433243Z","steps":["trace[788868803] 'process raft request'  (duration: 88.611853ms)","trace[788868803] 'compare'  (duration: 47.090668ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:29:00.433538Z","caller":"traceutil/trace.go:171","msg":"trace[1621476739] linearizableReadLoop","detail":"{readStateIndex:10149; appliedIndex:10146; }","duration":"109.360416ms","start":"2026-08-25T19:29:00.324153Z","end":"2026-08-25T19:29:00.433513Z","steps":["trace[1621476739] 'read index received'  (duration: 14.389034ms)","trace[1621476739] 'applied index is now lower than readState.Index'  (duration: 94.969252ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:29:00.433705Z","caller":"traceutil/trace.go:171","msg":"trace[222194843] transaction","detail":"{read_only:false; response_revision:9803; number_of_response:1; }","duration":"124.770929ms","start":"2026-08-25T19:29:00.308837Z","end":"2026-08-25T19:29:00.433608Z","steps":["trace[222194843] 'process raft request'  (duration: 124.33425ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:29:00.433931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.756074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:29:00.434039Z","caller":"traceutil/trace.go:171","msg":"trace[1515902127] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:9804; }","duration":"109.918687ms","start":"2026-08-25T19:29:00.324095Z","end":"2026-08-25T19:29:00.434014Z","steps":["trace[1515902127] 'agreement among raft nodes before linearized reading'  (duration: 109.522269ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:29:00.744085Z","caller":"traceutil/trace.go:171","msg":"trace[1047102537] linearizableReadLoop","detail":"{readStateIndex:10151; appliedIndex:10150; }","duration":"101.370612ms","start":"2026-08-25T19:29:00.642672Z","end":"2026-08-25T19:29:00.744042Z","steps":["trace[1047102537] 'read index received'  (duration: 101.023665ms)","trace[1047102537] 'applied index is now lower than readState.Index'  (duration: 344.857µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:29:00.744201Z","caller":"traceutil/trace.go:171","msg":"trace[1322209612] transaction","detail":"{read_only:false; response_revision:9805; number_of_response:1; }","duration":"252.58793ms","start":"2026-08-25T19:29:00.491559Z","end":"2026-08-25T19:29:00.744146Z","steps":["trace[1322209612] 'process raft request'  (duration: 252.240603ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:29:00.744374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.682819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5qbbw\" ","response":"range_response_count:1 size:6524"}
{"level":"info","ts":"2026-08-25T19:29:00.744476Z","caller":"traceutil/trace.go:171","msg":"trace[608311465] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5qbbw; range_end:; response_count:1; response_revision:9805; }","duration":"101.829723ms","start":"2026-08-25T19:29:00.642619Z","end":"2026-08-25T19:29:00.744449Z","steps":["trace[608311465] 'agreement among raft nodes before linearized reading'  (duration: 101.549206ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:30:14.841737Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7938}
{"level":"info","ts":"2026-08-25T19:30:14.911611Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7938,"took":"67.648885ms","hash":3124796369,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":28094464,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-25T19:30:14.911735Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3124796369,"revision":7938,"compact-revision":5714}
{"level":"info","ts":"2026-08-25T19:34:39.807509Z","caller":"traceutil/trace.go:171","msg":"trace[1039211076] transaction","detail":"{read_only:false; response_revision:12236; number_of_response:1; }","duration":"106.365395ms","start":"2026-08-25T19:34:39.700897Z","end":"2026-08-25T19:34:39.807262Z","steps":["trace[1039211076] 'process raft request'  (duration: 106.026718ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:35:14.849734Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10307}
{"level":"info","ts":"2026-08-25T19:35:14.936337Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10307,"took":"83.49754ms","hash":2615815995,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":26218496,"current-db-size-in-use":"26 MB"}
{"level":"info","ts":"2026-08-25T19:35:14.93652Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2615815995,"revision":10307,"compact-revision":7938}
{"level":"info","ts":"2026-08-25T19:40:14.858165Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12473}
{"level":"info","ts":"2026-08-25T19:40:14.938129Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12473,"took":"76.620496ms","hash":2436213173,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":27521024,"current-db-size-in-use":"28 MB"}
{"level":"info","ts":"2026-08-25T19:40:14.938231Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2436213173,"revision":12473,"compact-revision":10307}
{"level":"info","ts":"2026-08-25T19:41:26.411987Z","caller":"traceutil/trace.go:171","msg":"trace[1056095277] linearizableReadLoop","detail":"{readStateIndex:15443; appliedIndex:15442; }","duration":"128.162487ms","start":"2026-08-25T19:41:26.283787Z","end":"2026-08-25T19:41:26.411949Z","steps":["trace[1056095277] 'read index received'  (duration: 127.879671ms)","trace[1056095277] 'applied index is now lower than readState.Index'  (duration: 281.826µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:41:26.412457Z","caller":"traceutil/trace.go:171","msg":"trace[93169823] transaction","detail":"{read_only:false; response_revision:14924; number_of_response:1; }","duration":"137.166892ms","start":"2026-08-25T19:41:26.275273Z","end":"2026-08-25T19:41:26.41244Z","steps":["trace[93169823] 'process raft request'  (duration: 136.488017ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:41:26.412756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.939113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-08-25T19:41:26.412808Z","caller":"traceutil/trace.go:171","msg":"trace[627063825] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:14924; }","duration":"129.056076ms","start":"2026-08-25T19:41:26.283739Z","end":"2026-08-25T19:41:26.412795Z","steps":["trace[627063825] 'agreement among raft nodes before linearized reading'  (duration: 128.947134ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:41:50.997536Z","caller":"traceutil/trace.go:171","msg":"trace[154263432] transaction","detail":"{read_only:false; response_revision:15050; number_of_response:1; }","duration":"165.841047ms","start":"2026-08-25T19:41:50.83164Z","end":"2026-08-25T19:41:50.997481Z","steps":["trace[154263432] 'process raft request'  (duration: 165.455419ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:42:08.528466Z","caller":"traceutil/trace.go:171","msg":"trace[413435565] transaction","detail":"{read_only:false; response_revision:15153; number_of_response:1; }","duration":"265.166276ms","start":"2026-08-25T19:42:08.263269Z","end":"2026-08-25T19:42:08.528435Z","steps":["trace[413435565] 'process raft request'  (duration: 264.984092ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:42:08.558571Z","caller":"traceutil/trace.go:171","msg":"trace[821787758] transaction","detail":"{read_only:false; response_revision:15154; number_of_response:1; }","duration":"244.154536ms","start":"2026-08-25T19:42:08.314363Z","end":"2026-08-25T19:42:08.558518Z","steps":["trace[821787758] 'process raft request'  (duration: 224.830573ms)","trace[821787758] 'compare'  (duration: 19.041728ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:42:18.342735Z","caller":"traceutil/trace.go:171","msg":"trace[2016470531] transaction","detail":"{read_only:false; response_revision:15323; number_of_response:1; }","duration":"103.355561ms","start":"2026-08-25T19:42:18.239335Z","end":"2026-08-25T19:42:18.34269Z","steps":["trace[2016470531] 'process raft request'  (duration: 103.088456ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:42:18.572656Z","caller":"traceutil/trace.go:171","msg":"trace[1019015994] transaction","detail":"{read_only:false; response_revision:15324; number_of_response:1; }","duration":"157.882174ms","start":"2026-08-25T19:42:18.414742Z","end":"2026-08-25T19:42:18.572624Z","steps":["trace[1019015994] 'process raft request'  (duration: 157.709641ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:44:01.006295Z","caller":"traceutil/trace.go:171","msg":"trace[177337991] linearizableReadLoop","detail":"{readStateIndex:16989; appliedIndex:16988; }","duration":"222.961171ms","start":"2026-08-25T19:44:00.783309Z","end":"2026-08-25T19:44:01.00627Z","steps":["trace[177337991] 'read index received'  (duration: 222.733197ms)","trace[177337991] 'applied index is now lower than readState.Index'  (duration: 226.714µs)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:44:01.006676Z","caller":"traceutil/trace.go:171","msg":"trace[342689147] transaction","detail":"{read_only:false; response_revision:16422; number_of_response:1; }","duration":"242.241877ms","start":"2026-08-25T19:44:00.76442Z","end":"2026-08-25T19:44:01.006662Z","steps":["trace[342689147] 'process raft request'  (duration: 241.699466ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.007019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.688586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:44:01.007073Z","caller":"traceutil/trace.go:171","msg":"trace[26879466] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:16422; }","duration":"223.802038ms","start":"2026-08-25T19:44:00.783256Z","end":"2026-08-25T19:44:01.007058Z","steps":["trace[26879466] 'agreement among raft nodes before linearized reading'  (duration: 223.692216ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.007356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.555038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:44:01.0074Z","caller":"traceutil/trace.go:171","msg":"trace[837355826] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16422; }","duration":"214.62363ms","start":"2026-08-25T19:44:00.792762Z","end":"2026-08-25T19:44:01.007386Z","steps":["trace[837355826] 'agreement among raft nodes before linearized reading'  (duration: 214.550338ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.008344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.89406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-zh5j7\" ","response":"range_response_count:1 size:22094"}
{"level":"info","ts":"2026-08-25T19:44:01.00839Z","caller":"traceutil/trace.go:171","msg":"trace[774116988] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-zh5j7; range_end:; response_count:1; response_revision:16422; }","duration":"120.961471ms","start":"2026-08-25T19:44:00.887417Z","end":"2026-08-25T19:44:01.008378Z","steps":["trace[774116988] 'agreement among raft nodes before linearized reading'  (duration: 120.845177ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.008689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.330539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-zh5j7\" ","response":"range_response_count:1 size:22094"}
{"level":"info","ts":"2026-08-25T19:44:01.008731Z","caller":"traceutil/trace.go:171","msg":"trace[1004987612] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-zh5j7; range_end:; response_count:1; response_revision:16422; }","duration":"123.41107ms","start":"2026-08-25T19:44:00.885309Z","end":"2026-08-25T19:44:01.008721Z","steps":["trace[1004987612] 'agreement among raft nodes before linearized reading'  (duration: 123.297168ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.008981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.143561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5522"}
{"level":"info","ts":"2026-08-25T19:44:01.009025Z","caller":"traceutil/trace.go:171","msg":"trace[1051469544] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16422; }","duration":"214.206512ms","start":"2026-08-25T19:44:00.794808Z","end":"2026-08-25T19:44:01.009014Z","steps":["trace[1051469544] 'agreement among raft nodes before linearized reading'  (duration: 214.10234ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.009234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.350105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-user\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:44:01.009273Z","caller":"traceutil/trace.go:171","msg":"trace[546669308] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-user; range_end:; response_count:0; response_revision:16422; }","duration":"216.390285ms","start":"2026-08-25T19:44:00.792873Z","end":"2026-08-25T19:44:01.009263Z","steps":["trace[546669308] 'agreement among raft nodes before linearized reading'  (duration: 216.329344ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.009473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.63133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-ks-endpoints\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:44:01.009519Z","caller":"traceutil/trace.go:171","msg":"trace[615411698] range","detail":"{range_begin:/registry/jobs/openstack/nova-ks-endpoints; range_end:; response_count:0; response_revision:16422; }","duration":"216.690692ms","start":"2026-08-25T19:44:00.792816Z","end":"2026-08-25T19:44:01.009507Z","steps":["trace[615411698] 'agreement among raft nodes before linearized reading'  (duration: 216.625321ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:44:01.202663Z","caller":"traceutil/trace.go:171","msg":"trace[141822186] linearizableReadLoop","detail":"{readStateIndex:16990; appliedIndex:16989; }","duration":"186.144017ms","start":"2026-08-25T19:44:01.016498Z","end":"2026-08-25T19:44:01.202642Z","steps":["trace[141822186] 'read index received'  (duration: 144.633806ms)","trace[141822186] 'applied index is now lower than readState.Index'  (duration: 41.509361ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:44:01.203053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.520125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18730"}
{"level":"info","ts":"2026-08-25T19:44:01.203094Z","caller":"traceutil/trace.go:171","msg":"trace[1244538681] transaction","detail":"{read_only:false; response_revision:16423; number_of_response:1; }","duration":"191.19879ms","start":"2026-08-25T19:44:01.011867Z","end":"2026-08-25T19:44:01.203066Z","steps":["trace[1244538681] 'process raft request'  (duration: 149.325671ms)","trace[1244538681] 'compare'  (duration: 41.357458ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:44:01.203132Z","caller":"traceutil/trace.go:171","msg":"trace[126670824] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:16423; }","duration":"186.649337ms","start":"2026-08-25T19:44:01.016469Z","end":"2026-08-25T19:44:01.203119Z","steps":["trace[126670824] 'agreement among raft nodes before linearized reading'  (duration: 186.339271ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.203301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.986753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5522"}
{"level":"info","ts":"2026-08-25T19:44:01.203353Z","caller":"traceutil/trace.go:171","msg":"trace[720784168] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:16423; }","duration":"185.058164ms","start":"2026-08-25T19:44:01.018281Z","end":"2026-08-25T19:44:01.203339Z","steps":["trace[720784168] 'agreement among raft nodes before linearized reading'  (duration: 184.934532ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.203488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.827851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769813"}
{"level":"info","ts":"2026-08-25T19:44:01.203511Z","caller":"traceutil/trace.go:171","msg":"trace[281011649] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16423; }","duration":"186.879502ms","start":"2026-08-25T19:44:01.016624Z","end":"2026-08-25T19:44:01.203504Z","steps":["trace[281011649] 'agreement among raft nodes before linearized reading'  (duration: 186.248529ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.20365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.752178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"}
{"level":"info","ts":"2026-08-25T19:44:01.203694Z","caller":"traceutil/trace.go:171","msg":"trace[1483315399] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:16423; }","duration":"185.809659ms","start":"2026-08-25T19:44:01.017871Z","end":"2026-08-25T19:44:01.20368Z","steps":["trace[1483315399] 'agreement among raft nodes before linearized reading'  (duration: 185.681267ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.203703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.812279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:44:01.203758Z","caller":"traceutil/trace.go:171","msg":"trace[1095427054] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:16423; }","duration":"185.87793ms","start":"2026-08-25T19:44:01.017867Z","end":"2026-08-25T19:44:01.203745Z","steps":["trace[1095427054] 'agreement among raft nodes before linearized reading'  (duration: 185.725797ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:44:01.209921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.26796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:79 size:769813"}
{"level":"info","ts":"2026-08-25T19:44:01.210056Z","caller":"traceutil/trace.go:171","msg":"trace[468686706] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:79; response_revision:16423; }","duration":"190.408534ms","start":"2026-08-25T19:44:01.019605Z","end":"2026-08-25T19:44:01.210014Z","steps":["trace[468686706] 'agreement among raft nodes before linearized reading'  (duration: 183.90905ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:45:14.870504Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14472}
{"level":"info","ts":"2026-08-25T19:45:14.965082Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14472,"took":"90.517366ms","hash":3245363512,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":31277056,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-25T19:45:14.965169Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3245363512,"revision":14472,"compact-revision":12473}
{"level":"info","ts":"2026-08-25T19:49:05.336983Z","caller":"traceutil/trace.go:171","msg":"trace[409771032] transaction","detail":"{read_only:false; response_revision:18629; number_of_response:1; }","duration":"100.874082ms","start":"2026-08-25T19:49:05.23606Z","end":"2026-08-25T19:49:05.336934Z","steps":["trace[409771032] 'process raft request'  (duration: 100.617637ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:49:42.741897Z","caller":"traceutil/trace.go:171","msg":"trace[328468762] linearizableReadLoop","detail":"{readStateIndex:19509; appliedIndex:19508; }","duration":"197.55984ms","start":"2026-08-25T19:49:42.544313Z","end":"2026-08-25T19:49:42.741873Z","steps":["trace[328468762] 'read index received'  (duration: 197.436688ms)","trace[328468762] 'applied index is now lower than readState.Index'  (duration: 121.762µs)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:49:42.742143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.772194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"}
{"level":"info","ts":"2026-08-25T19:49:42.742186Z","caller":"traceutil/trace.go:171","msg":"trace[1393669613] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18861; }","duration":"197.917618ms","start":"2026-08-25T19:49:42.544256Z","end":"2026-08-25T19:49:42.742174Z","steps":["trace[1393669613] 'agreement among raft nodes before linearized reading'  (duration: 197.708813ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:49:42.742153Z","caller":"traceutil/trace.go:171","msg":"trace[861126834] transaction","detail":"{read_only:false; response_revision:18861; number_of_response:1; }","duration":"220.668913ms","start":"2026-08-25T19:49:42.521263Z","end":"2026-08-25T19:49:42.741932Z","steps":["trace[861126834] 'process raft request'  (duration: 220.448458ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:49:42.757063Z","caller":"traceutil/trace.go:171","msg":"trace[2145394957] transaction","detail":"{read_only:false; response_revision:18862; number_of_response:1; }","duration":"131.503289ms","start":"2026-08-25T19:49:42.625531Z","end":"2026-08-25T19:49:42.757034Z","steps":["trace[2145394957] 'process raft request'  (duration: 131.313355ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:49:43.146497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.083995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"}
{"level":"info","ts":"2026-08-25T19:49:43.146616Z","caller":"traceutil/trace.go:171","msg":"trace[585227326] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18862; }","duration":"253.251888ms","start":"2026-08-25T19:49:42.89334Z","end":"2026-08-25T19:49:43.146591Z","steps":["trace[585227326] 'range keys from in-memory index tree'  (duration: 251.906651ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:49:43.278575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.774828ms","expected-duration":"100ms","prefix":"","request":"header:<ID:4135606530219799115 > lease_revoke:<id:3964a03a54897123>","response":"size:29"}
{"level":"info","ts":"2026-08-25T19:49:43.278728Z","caller":"traceutil/trace.go:171","msg":"trace[282662599] linearizableReadLoop","detail":"{readStateIndex:19511; appliedIndex:19510; }","duration":"152.262823ms","start":"2026-08-25T19:49:43.126441Z","end":"2026-08-25T19:49:43.278704Z","steps":["trace[282662599] 'read index received'  (duration: 33.462085ms)","trace[282662599] 'applied index is now lower than readState.Index'  (duration: 118.798178ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:49:43.279059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.60902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"}
{"level":"info","ts":"2026-08-25T19:49:43.279168Z","caller":"traceutil/trace.go:171","msg":"trace[290730727] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18862; }","duration":"152.707902ms","start":"2026-08-25T19:49:43.126394Z","end":"2026-08-25T19:49:43.279102Z","steps":["trace[290730727] 'agreement among raft nodes before linearized reading'  (duration: 152.438957ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:49:43.279271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.217202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"}
{"level":"info","ts":"2026-08-25T19:49:43.279416Z","caller":"traceutil/trace.go:171","msg":"trace[664646225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:18862; }","duration":"152.418187ms","start":"2026-08-25T19:49:43.126954Z","end":"2026-08-25T19:49:43.279372Z","steps":["trace[664646225] 'agreement among raft nodes before linearized reading'  (duration: 151.941977ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:49:51.733503Z","caller":"traceutil/trace.go:171","msg":"trace[413356105] transaction","detail":"{read_only:false; response_revision:18963; number_of_response:1; }","duration":"121.360871ms","start":"2026-08-25T19:49:51.612091Z","end":"2026-08-25T19:49:51.733452Z","steps":["trace[413356105] 'process raft request'  (duration: 121.016474ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:50:14.878666Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":16886}
{"level":"info","ts":"2026-08-25T19:50:14.977287Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":16886,"took":"94.080794ms","hash":3885222665,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":32026624,"current-db-size-in-use":"32 MB"}
{"level":"info","ts":"2026-08-25T19:50:14.977357Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3885222665,"revision":16886,"compact-revision":14472}
{"level":"info","ts":"2026-08-25T19:50:26.33358Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9755887b76c83964","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-25T19:50:26.340807Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002}
{"level":"info","ts":"2026-08-25T19:50:26.340952Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002}
{"level":"info","ts":"2026-08-25T19:54:35.043649Z","caller":"traceutil/trace.go:171","msg":"trace[23078727] transaction","detail":"{read_only:false; response_revision:21133; number_of_response:1; }","duration":"104.17548ms","start":"2026-08-25T19:54:34.939447Z","end":"2026-08-25T19:54:35.043622Z","steps":["trace[23078727] 'process raft request'  (duration: 99.245799ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:55:14.88494Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19198}
{"level":"info","ts":"2026-08-25T19:55:14.985171Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19198,"took":"95.567283ms","hash":1202559501,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":34615296,"current-db-size-in-use":"35 MB"}
{"level":"info","ts":"2026-08-25T19:55:14.985237Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1202559501,"revision":19198,"compact-revision":16886}
{"level":"warn","ts":"2026-08-25T19:56:26.723878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.904767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"}
{"level":"info","ts":"2026-08-25T19:56:26.724008Z","caller":"traceutil/trace.go:171","msg":"trace[164248088] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:21953; }","duration":"154.122671ms","start":"2026-08-25T19:56:26.569859Z","end":"2026-08-25T19:56:26.723981Z","steps":["trace[164248088] 'range keys from in-memory index tree'  (duration: 153.63454ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:56:26.747207Z","caller":"traceutil/trace.go:171","msg":"trace[1830692792] transaction","detail":"{read_only:false; response_revision:21954; number_of_response:1; }","duration":"134.651014ms","start":"2026-08-25T19:56:26.612532Z","end":"2026-08-25T19:56:26.747183Z","steps":["trace[1830692792] 'process raft request'  (duration: 134.388278ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:56:42.905192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.670199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:56:42.905294Z","caller":"traceutil/trace.go:171","msg":"trace[526240987] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22034; }","duration":"145.837692ms","start":"2026-08-25T19:56:42.759435Z","end":"2026-08-25T19:56:42.905273Z","steps":["trace[526240987] 'range keys from in-memory index tree'  (duration: 145.575147ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:56:43.386632Z","caller":"traceutil/trace.go:171","msg":"trace[1194526176] transaction","detail":"{read_only:false; response_revision:22036; number_of_response:1; }","duration":"138.656326ms","start":"2026-08-25T19:56:43.247951Z","end":"2026-08-25T19:56:43.386608Z","steps":["trace[1194526176] 'process raft request'  (duration: 138.176145ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:56:43.722404Z","caller":"traceutil/trace.go:171","msg":"trace[1221969551] transaction","detail":"{read_only:false; response_revision:22037; number_of_response:1; }","duration":"158.582104ms","start":"2026-08-25T19:56:43.563792Z","end":"2026-08-25T19:56:43.722374Z","steps":["trace[1221969551] 'process raft request'  (duration: 158.349358ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T19:56:43.880452Z","caller":"traceutil/trace.go:171","msg":"trace[1420695599] linearizableReadLoop","detail":"{readStateIndex:22792; appliedIndex:22791; }","duration":"125.884254ms","start":"2026-08-25T19:56:43.754533Z","end":"2026-08-25T19:56:43.880418Z","steps":["trace[1420695599] 'read index received'  (duration: 92.638884ms)","trace[1420695599] 'applied index is now lower than readState.Index'  (duration: 33.24385ms)"],"step_count":2}
{"level":"info","ts":"2026-08-25T19:56:43.880614Z","caller":"traceutil/trace.go:171","msg":"trace[1054780694] transaction","detail":"{read_only:false; response_revision:22038; number_of_response:1; }","duration":"315.540843ms","start":"2026-08-25T19:56:43.56506Z","end":"2026-08-25T19:56:43.880601Z","steps":["trace[1054780694] 'process raft request'  (duration: 282.073448ms)","trace[1054780694] 'compare'  (duration: 33.117688ms)"],"step_count":2}
{"level":"warn","ts":"2026-08-25T19:56:43.880749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-25T19:56:43.565037Z","time spent":"315.612625ms","remote":"127.0.0.1:57382","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:22029 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-08-25T19:56:43.880743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.760502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"}
{"level":"info","ts":"2026-08-25T19:56:43.880831Z","caller":"traceutil/trace.go:171","msg":"trace[301538463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:22038; }","duration":"125.887025ms","start":"2026-08-25T19:56:43.754919Z","end":"2026-08-25T19:56:43.880806Z","steps":["trace[301538463] 'agreement among raft nodes before linearized reading'  (duration: 125.742852ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:56:43.881017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.470916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"}
{"level":"info","ts":"2026-08-25T19:56:43.881104Z","caller":"traceutil/trace.go:171","msg":"trace[1556378410] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22038; }","duration":"126.610419ms","start":"2026-08-25T19:56:43.754475Z","end":"2026-08-25T19:56:43.881086Z","steps":["trace[1556378410] 'agreement among raft nodes before linearized reading'  (duration: 126.347204ms)"],"step_count":1}
{"level":"warn","ts":"2026-08-25T19:56:43.881166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.442551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"}
{"level":"info","ts":"2026-08-25T19:56:43.881208Z","caller":"traceutil/trace.go:171","msg":"trace[1192488323] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22038; }","duration":"116.512252ms","start":"2026-08-25T19:56:43.764686Z","end":"2026-08-25T19:56:43.881198Z","steps":["trace[1192488323] 'agreement among raft nodes before linearized reading'  (duration: 116.361239ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T20:00:14.891886Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21542}
{"level":"info","ts":"2026-08-25T20:00:15.008939Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21542,"took":"111.369988ms","hash":2529341758,"current-db-size-bytes":55607296,"current-db-size":"56 MB","current-db-size-in-use-bytes":31076352,"current-db-size-in-use":"31 MB"}
{"level":"info","ts":"2026-08-25T20:00:15.009028Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2529341758,"revision":21542,"compact-revision":19198}
{"level":"info","ts":"2026-08-25T20:01:00.086157Z","caller":"traceutil/trace.go:171","msg":"trace[913852255] transaction","detail":"{read_only:false; response_revision:24696; number_of_response:1; }","duration":"107.940026ms","start":"2026-08-25T20:00:59.978162Z","end":"2026-08-25T20:01:00.086102Z","steps":["trace[913852255] 'process raft request'  (duration: 107.701332ms)"],"step_count":1}
{"level":"info","ts":"2026-08-25T20:02:47.921362Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000067fe.wal"}
{"level":"info","ts":"2026-08-25T20:05:14.899599Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23775}
{"level":"info","ts":"2026-08-25T20:05:15.014089Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23775,"took":"110.089559ms","hash":715578799,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":42754048,"current-db-size-in-use":"43 MB"}
{"level":"info","ts":"2026-08-25T20:05:15.014147Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":715578799,"revision":23775,"compact-revision":21542}
{"level":"info","ts":"2026-08-25T20:10:04.969345Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"9755887b76c83964","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000}
{"level":"info","ts":"2026-08-25T20:10:04.973609Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003}
{"level":"info","ts":"2026-08-25T20:10:04.973704Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003}
{"level":"info","ts":"2026-08-25T20:10:14.907927Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26910}
{"level":"info","ts":"2026-08-25T20:10:15.041337Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26910,"took":"129.141427ms","hash":1554397126,"current-db-size-bytes":56451072,"current-db-size":"56 MB","current-db-size-in-use-bytes":30187520,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-08-25T20:10:15.041408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1554397126,"revision":26910,"compact-revision":23775}