{"level":"warn","ts":"2026-09-17T19:17:21.074716Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-17T19:17:21.074897Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79: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.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-17T19:17:21.07498Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-17T19:17:21.075002Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-17T19:17:21.075021Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-17T19:17:21.075924Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]} {"level":"info","ts":"2026-09-17T19:17:21.076023Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-17T19:17:21.082297Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.61296ms"} {"level":"info","ts":"2026-09-17T19:17:21.089798Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"} {"level":"info","ts":"2026-09-17T19:17:21.089874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"} {"level":"info","ts":"2026-09-17T19:17:21.089901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"} {"level":"info","ts":"2026-09-17T19:17:21.089913Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-17T19:17:21.089924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"} {"level":"info","ts":"2026-09-17T19:17:21.089966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"warn","ts":"2026-09-17T19:17:21.102823Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-17T19:17:21.104952Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-17T19:17:21.106149Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-17T19:17:21.108961Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-17T19:17:21.109228Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-17T19:17:21.109316Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-17T19:17:21.109325Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-17T19:17:21.109368Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-17T19:17:21.115159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"} {"level":"info","ts":"2026-09-17T19:17:21.115404Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]} {"level":"info","ts":"2026-09-17T19:17:21.116861Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-17T19:17:21.116947Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-17T19:17:21.116987Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"} {"level":"info","ts":"2026-09-17T19:17:21.117223Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-17T19:17:21.117252Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-17T19:17:21.490347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"} {"level":"info","ts":"2026-09-17T19:17:21.490435Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"} {"level":"info","ts":"2026-09-17T19:17:21.49048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"} {"level":"info","ts":"2026-09-17T19:17:21.490498Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"} {"level":"info","ts":"2026-09-17T19:17:21.490509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-17T19:17:21.490524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"} {"level":"info","ts":"2026-09-17T19:17:21.490536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"} {"level":"info","ts":"2026-09-17T19:17:21.491685Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"} {"level":"info","ts":"2026-09-17T19:17:21.491845Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-17T19:17:21.491916Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T19:17:21.492814Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T19:17:21.492875Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T19:17:21.492892Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-17T19:17:21.492902Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-17T19:17:21.494634Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-17T19:17:21.495522Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"} {"level":"info","ts":"2026-09-17T19:17:21.496346Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-17T19:17:21.496375Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-17T19:17:27.661352Z","caller":"traceutil/trace.go:171","msg":"trace[1822052390] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"166.258624ms","start":"2026-09-17T19:17:27.495069Z","end":"2026-09-17T19:17:27.661327Z","steps":["trace[1822052390] 'process raft request' (duration: 166.180488ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:17:27.959491Z","caller":"traceutil/trace.go:171","msg":"trace[1258401189] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"462.062177ms","start":"2026-09-17T19:17:27.497387Z","end":"2026-09-17T19:17:27.95945Z","steps":["trace[1258401189] 'process raft request' (duration: 461.896895ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:17:27.959591Z","caller":"traceutil/trace.go:171","msg":"trace[1466507907] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:317; }","duration":"297.060671ms","start":"2026-09-17T19:17:27.662504Z","end":"2026-09-17T19:17:27.959564Z","steps":["trace[1466507907] 'read index received' (duration: 296.779501ms)","trace[1466507907] 'applied index is now lower than readState.Index' (duration: 280.36µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:17:27.959764Z","caller":"traceutil/trace.go:171","msg":"trace[1650914713] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"462.232369ms","start":"2026-09-17T19:17:27.497516Z","end":"2026-09-17T19:17:27.959748Z","steps":["trace[1650914713] 'process raft request' (duration: 461.851932ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:17:27.959852Z","caller":"traceutil/trace.go:171","msg":"trace[1319718379] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"434.44196ms","start":"2026-09-17T19:17:27.525398Z","end":"2026-09-17T19:17:27.95984Z","steps":["trace[1319718379] 'process raft request' (duration: 434.102897ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:17:27.959983Z","caller":"traceutil/trace.go:171","msg":"trace[1222058815] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"460.389579ms","start":"2026-09-17T19:17:27.499569Z","end":"2026-09-17T19:17:27.959958Z","steps":["trace[1222058815] 'process raft request' (duration: 459.822049ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:27.959973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.411416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-09-17T19:17:27.960022Z","caller":"traceutil/trace.go:171","msg":"trace[1054166859] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"457.483153ms","start":"2026-09-17T19:17:27.502494Z","end":"2026-09-17T19:17:27.959977Z","steps":["trace[1054166859] 'process raft request' (duration: 456.917443ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:27.960013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.94925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-17T19:17:27.960075Z","caller":"traceutil/trace.go:171","msg":"trace[356546889] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:310; }","duration":"297.588818ms","start":"2026-09-17T19:17:27.662468Z","end":"2026-09-17T19:17:27.960057Z","steps":["trace[356546889] 'agreement among raft nodes before linearized reading' (duration: 297.356701ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:17:27.960123Z","caller":"traceutil/trace.go:171","msg":"trace[701515689] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:310; }","duration":"115.124183ms","start":"2026-09-17T19:17:27.844976Z","end":"2026-09-17T19:17:27.960101Z","steps":["trace[701515689] 'agreement among raft nodes before linearized reading' (duration: 114.909187ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:27.96026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:17:27.497372Z","time spent":"462.207857ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T19:17:27.96043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:17:27.497491Z","time spent":"462.316784ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T19:17:27.960746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:17:27.525378Z","time spent":"434.507405ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T19:17:27.960783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:17:27.499553Z","time spent":"460.502526ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T19:17:27.960882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:17:27.50248Z","time spent":"457.611362ms","remote":"127.0.0.1:37016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T19:17:28.249476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.280924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/resourcequota-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-09-17T19:17:28.249532Z","caller":"traceutil/trace.go:171","msg":"trace[2047493970] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/resourcequota-controller; range_end:; response_count:1; response_revision:310; }","duration":"285.37246ms","start":"2026-09-17T19:17:27.964147Z","end":"2026-09-17T19:17:28.249519Z","steps":["trace[2047493970] 'range keys from in-memory index tree' (duration: 285.186457ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:28.249536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.36725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-09-17T19:17:28.249647Z","caller":"traceutil/trace.go:171","msg":"trace[1303064852] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:310; }","duration":"285.524801ms","start":"2026-09-17T19:17:27.964099Z","end":"2026-09-17T19:17:28.249624Z","steps":["trace[1303064852] 'range keys from in-memory index tree' (duration: 285.280093ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:28.249745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.132124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"warn","ts":"2026-09-17T19:17:28.24979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.460987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-09-17T19:17:28.249808Z","caller":"traceutil/trace.go:171","msg":"trace[507088985] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:310; }","duration":"287.512191ms","start":"2026-09-17T19:17:27.962291Z","end":"2026-09-17T19:17:28.249803Z","steps":["trace[507088985] 'range keys from in-memory index tree' (duration: 287.394473ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:17:28.249815Z","caller":"traceutil/trace.go:171","msg":"trace[1003814318] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:310; }","duration":"287.299707ms","start":"2026-09-17T19:17:27.962494Z","end":"2026-09-17T19:17:28.249794Z","steps":["trace[1003814318] 'range keys from in-memory index tree' (duration: 287.045748ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:28.24986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.381112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5892"} {"level":"info","ts":"2026-09-17T19:17:28.249874Z","caller":"traceutil/trace.go:171","msg":"trace[1056569160] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:310; }","duration":"287.410534ms","start":"2026-09-17T19:17:27.962459Z","end":"2026-09-17T19:17:28.24987Z","steps":["trace[1056569160] 'range keys from in-memory index tree' (duration: 287.3486ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:28.249918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.569225ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T19:17:28.250033Z","caller":"traceutil/trace.go:171","msg":"trace[1671890883] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"285.432064ms","start":"2026-09-17T19:17:27.964582Z","end":"2026-09-17T19:17:28.250014Z","steps":["trace[1671890883] 'process raft request' (duration: 176.492804ms)","trace[1671890883] 'compare' (duration: 108.262653ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:17:28.433794Z","caller":"traceutil/trace.go:171","msg":"trace[909407323] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:323; }","duration":"164.934653ms","start":"2026-09-17T19:17:28.268836Z","end":"2026-09-17T19:17:28.43377Z","steps":["trace[909407323] 'read index received' (duration: 164.667794ms)","trace[909407323] 'applied index is now lower than readState.Index' (duration: 266.079µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:17:28.433948Z","caller":"traceutil/trace.go:171","msg":"trace[628949579] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"172.354088ms","start":"2026-09-17T19:17:28.261548Z","end":"2026-09-17T19:17:28.433903Z","steps":["trace[628949579] 'process raft request' (duration: 172.026875ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:17:28.433999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.134787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T19:17:28.434082Z","caller":"traceutil/trace.go:171","msg":"trace[447980825] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:312; }","duration":"165.248035ms","start":"2026-09-17T19:17:28.268805Z","end":"2026-09-17T19:17:28.434053Z","steps":["trace[447980825] 'agreement among raft nodes before linearized reading' (duration: 165.092514ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.607722Z","caller":"traceutil/trace.go:171","msg":"trace[1450624027] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"268.256889ms","start":"2026-09-17T19:18:02.33944Z","end":"2026-09-17T19:18:02.607697Z","steps":["trace[1450624027] 'process raft request' (duration: 268.21253ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.607768Z","caller":"traceutil/trace.go:171","msg":"trace[1364557447] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"271.160559ms","start":"2026-09-17T19:18:02.336564Z","end":"2026-09-17T19:18:02.607725Z","steps":["trace[1364557447] 'process raft request' (duration: 253.062636ms)","trace[1364557447] 'compare' (duration: 17.815493ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:18:02.61281Z","caller":"traceutil/trace.go:171","msg":"trace[1016441907] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"258.631543ms","start":"2026-09-17T19:18:02.354155Z","end":"2026-09-17T19:18:02.612787Z","steps":["trace[1016441907] 'process raft request' (duration: 258.370403ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.612789Z","caller":"traceutil/trace.go:171","msg":"trace[928742263] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"261.069891ms","start":"2026-09-17T19:18:02.351642Z","end":"2026-09-17T19:18:02.612711Z","steps":["trace[928742263] 'process raft request' (duration: 260.716824ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.613074Z","caller":"traceutil/trace.go:171","msg":"trace[801915520] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"258.592595ms","start":"2026-09-17T19:18:02.35441Z","end":"2026-09-17T19:18:02.613003Z","steps":["trace[801915520] 'process raft request' (duration: 258.312175ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.613108Z","caller":"traceutil/trace.go:171","msg":"trace[605343710] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"250.160605ms","start":"2026-09-17T19:18:02.362918Z","end":"2026-09-17T19:18:02.613079Z","steps":["trace[605343710] 'process raft request' (duration: 249.909004ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.613272Z","caller":"traceutil/trace.go:171","msg":"trace[1659898807] transaction","detail":"{read_only:false; number_of_response:1; response_revision:539; }","duration":"258.906873ms","start":"2026-09-17T19:18:02.354342Z","end":"2026-09-17T19:18:02.613249Z","steps":["trace[1659898807] 'process raft request' (duration: 258.343035ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.613422Z","caller":"traceutil/trace.go:171","msg":"trace[502962028] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"255.461924ms","start":"2026-09-17T19:18:02.357901Z","end":"2026-09-17T19:18:02.613363Z","steps":["trace[502962028] 'process raft request' (duration: 254.873896ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.613543Z","caller":"traceutil/trace.go:171","msg":"trace[258657781] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"250.54561ms","start":"2026-09-17T19:18:02.362932Z","end":"2026-09-17T19:18:02.613478Z","steps":["trace[258657781] 'process raft request' (duration: 249.944284ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.619176Z","caller":"traceutil/trace.go:171","msg":"trace[316798297] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:556; }","duration":"260.989074ms","start":"2026-09-17T19:18:02.358169Z","end":"2026-09-17T19:18:02.619158Z","steps":["trace[316798297] 'read index received' (duration: 231.544381ms)","trace[316798297] 'applied index is now lower than readState.Index' (duration: 29.443643ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:18:02.619269Z","caller":"traceutil/trace.go:171","msg":"trace[570742271] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"253.069754ms","start":"2026-09-17T19:18:02.366187Z","end":"2026-09-17T19:18:02.619257Z","steps":["trace[570742271] 'process raft request' (duration: 247.445888ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.61942Z","caller":"traceutil/trace.go:171","msg":"trace[1510176515] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"203.519213ms","start":"2026-09-17T19:18:02.415886Z","end":"2026-09-17T19:18:02.619405Z","steps":["trace[1510176515] 'process raft request' (duration: 203.110598ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.619589Z","caller":"traceutil/trace.go:171","msg":"trace[259370776] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"237.769774ms","start":"2026-09-17T19:18:02.381811Z","end":"2026-09-17T19:18:02.619581Z","steps":["trace[259370776] 'process raft request' (duration: 236.82314ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:02.619646Z","caller":"traceutil/trace.go:171","msg":"trace[1985358499] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"206.598267ms","start":"2026-09-17T19:18:02.413041Z","end":"2026-09-17T19:18:02.619639Z","steps":["trace[1985358499] 'process raft request' (duration: 205.730409ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:18:02.619911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.458997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T19:18:02.619965Z","caller":"traceutil/trace.go:171","msg":"trace[1074218317] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:548; }","duration":"261.809724ms","start":"2026-09-17T19:18:02.358141Z","end":"2026-09-17T19:18:02.619951Z","steps":["trace[1074218317] 'agreement among raft nodes before linearized reading' (duration: 261.441127ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:18:02.621751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.182945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-09-17T19:18:02.621838Z","caller":"traceutil/trace.go:171","msg":"trace[2106849197] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:549; }","duration":"203.307991ms","start":"2026-09-17T19:18:02.418515Z","end":"2026-09-17T19:18:02.621823Z","steps":["trace[2106849197] 'agreement among raft nodes before linearized reading' (duration: 203.046681ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:09.441175Z","caller":"traceutil/trace.go:171","msg":"trace[1770384082] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"151.61806ms","start":"2026-09-17T19:18:09.289229Z","end":"2026-09-17T19:18:09.440847Z","steps":["trace[1770384082] 'process raft request' (duration: 151.409945ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:10.051298Z","caller":"traceutil/trace.go:171","msg":"trace[843737564] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"428.081178ms","start":"2026-09-17T19:18:09.623173Z","end":"2026-09-17T19:18:10.051254Z","steps":["trace[843737564] 'read index received' (duration: 427.922261ms)","trace[843737564] 'applied index is now lower than readState.Index' (duration: 157.106µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:18:10.051536Z","caller":"traceutil/trace.go:171","msg":"trace[1586036147] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"567.535242ms","start":"2026-09-17T19:18:09.483882Z","end":"2026-09-17T19:18:10.051417Z","steps":["trace[1586036147] 'process raft request' (duration: 567.071954ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:18:10.051874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:18:09.483849Z","time spent":"567.886093ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T19:18:10.052512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.286426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p27f4\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-09-17T19:18:10.052571Z","caller":"traceutil/trace.go:171","msg":"trace[54298659] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p27f4; range_end:; response_count:1; response_revision:650; }","duration":"429.451891ms","start":"2026-09-17T19:18:09.623101Z","end":"2026-09-17T19:18:10.052553Z","steps":["trace[54298659] 'agreement among raft nodes before linearized reading' (duration: 428.307712ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:18:10.052616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:18:09.62307Z","time spent":"429.534609ms","remote":"127.0.0.1:37004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-p27f4\" "} {"level":"info","ts":"2026-09-17T19:18:26.026443Z","caller":"traceutil/trace.go:171","msg":"trace[1826031252] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"278.285626ms","start":"2026-09-17T19:18:25.74814Z","end":"2026-09-17T19:18:26.026425Z","steps":["trace[1826031252] 'process raft request' (duration: 278.147717ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:38.793882Z","caller":"traceutil/trace.go:171","msg":"trace[1230125538] transaction","detail":"{read_only:false; response_revision:949; number_of_response:1; }","duration":"111.957855ms","start":"2026-09-17T19:18:38.681898Z","end":"2026-09-17T19:18:38.793856Z","steps":["trace[1230125538] 'process raft request' (duration: 102.670469ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:18:59.136131Z","caller":"traceutil/trace.go:171","msg":"trace[249298482] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"121.159878ms","start":"2026-09-17T19:18:59.014934Z","end":"2026-09-17T19:18:59.136094Z","steps":["trace[249298482] 'process raft request' (duration: 120.793419ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:19:23.021555Z","caller":"traceutil/trace.go:171","msg":"trace[1441776531] transaction","detail":"{read_only:false; response_revision:1487; number_of_response:1; }","duration":"110.792578ms","start":"2026-09-17T19:19:22.910736Z","end":"2026-09-17T19:19:23.021529Z","steps":["trace[1441776531] 'process raft request' (duration: 110.606522ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:19:23.031681Z","caller":"traceutil/trace.go:171","msg":"trace[1888700479] transaction","detail":"{read_only:false; response_revision:1488; number_of_response:1; }","duration":"116.952436ms","start":"2026-09-17T19:19:22.914681Z","end":"2026-09-17T19:19:23.031634Z","steps":["trace[1888700479] 'process raft request' (duration: 114.466593ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:19:51.777423Z","caller":"traceutil/trace.go:171","msg":"trace[522788206] linearizableReadLoop","detail":"{readStateIndex:1994; appliedIndex:1993; }","duration":"226.599141ms","start":"2026-09-17T19:19:51.550793Z","end":"2026-09-17T19:19:51.777392Z","steps":["trace[522788206] 'read index received' (duration: 149.615674ms)","trace[522788206] 'applied index is now lower than readState.Index' (duration: 76.981907ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:19:51.777632Z","caller":"traceutil/trace.go:171","msg":"trace[1010814077] transaction","detail":"{read_only:false; response_revision:1915; number_of_response:1; }","duration":"283.556059ms","start":"2026-09-17T19:19:51.494028Z","end":"2026-09-17T19:19:51.777584Z","steps":["trace[1010814077] 'process raft request' (duration: 206.484299ms)","trace[1010814077] 'compare' (duration: 76.697474ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T19:19:51.777932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.961626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-17T19:19:51.777902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.230185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-09-17T19:19:51.778057Z","caller":"traceutil/trace.go:171","msg":"trace[1158414396] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1915; }","duration":"220.405702ms","start":"2026-09-17T19:19:51.55762Z","end":"2026-09-17T19:19:51.778026Z","steps":["trace[1158414396] 'agreement among raft nodes before linearized reading' (duration: 220.039017ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:19:51.778119Z","caller":"traceutil/trace.go:171","msg":"trace[980245483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1915; }","duration":"227.388065ms","start":"2026-09-17T19:19:51.550719Z","end":"2026-09-17T19:19:51.778107Z","steps":["trace[980245483] 'agreement among raft nodes before linearized reading' (duration: 226.856872ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:19:51.992477Z","caller":"traceutil/trace.go:171","msg":"trace[674293863] transaction","detail":"{read_only:false; response_revision:1916; number_of_response:1; }","duration":"208.908123ms","start":"2026-09-17T19:19:51.783537Z","end":"2026-09-17T19:19:51.992445Z","steps":["trace[674293863] 'process raft request' (duration: 160.163921ms)","trace[674293863] 'compare' (duration: 48.494062ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:19:51.992884Z","caller":"traceutil/trace.go:171","msg":"trace[259963571] linearizableReadLoop","detail":"{readStateIndex:1996; appliedIndex:1994; }","duration":"150.602807ms","start":"2026-09-17T19:19:51.842247Z","end":"2026-09-17T19:19:51.992849Z","steps":["trace[259963571] 'read index received' (duration: 101.504778ms)","trace[259963571] 'applied index is now lower than readState.Index' (duration: 49.096519ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:19:51.993158Z","caller":"traceutil/trace.go:171","msg":"trace[1068972061] transaction","detail":"{read_only:false; response_revision:1917; number_of_response:1; }","duration":"208.940406ms","start":"2026-09-17T19:19:51.784186Z","end":"2026-09-17T19:19:51.993126Z","steps":["trace[1068972061] 'process raft request' (duration: 208.235104ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:19:51.993282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.987774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6c3eab4e-b679-47c2-9b64-80571fa52424\" ","response":"range_response_count:1 size:3740"} {"level":"info","ts":"2026-09-17T19:19:51.993371Z","caller":"traceutil/trace.go:171","msg":"trace[996763335] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6c3eab4e-b679-47c2-9b64-80571fa52424; range_end:; response_count:1; response_revision:1917; }","duration":"151.182533ms","start":"2026-09-17T19:19:51.842172Z","end":"2026-09-17T19:19:51.993355Z","steps":["trace[996763335] 'agreement among raft nodes before linearized reading' (duration: 150.792896ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:05.214831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.926677ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T19:20:05.214953Z","caller":"traceutil/trace.go:171","msg":"trace[1499760383] linearizableReadLoop","detail":"{readStateIndex:2110; appliedIndex:2109; }","duration":"312.318903ms","start":"2026-09-17T19:20:04.902612Z","end":"2026-09-17T19:20:05.214931Z","steps":["trace[1499760383] 'read index received' (duration: 79.144µs)","trace[1499760383] 'applied index is now lower than readState.Index' (duration: 312.237959ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:20:05.215058Z","caller":"traceutil/trace.go:171","msg":"trace[1199707766] transaction","detail":"{read_only:false; response_revision:2027; number_of_response:1; }","duration":"391.273814ms","start":"2026-09-17T19:20:04.823772Z","end":"2026-09-17T19:20:05.215045Z","steps":["trace[1199707766] 'process raft request' (duration: 46.99257ms)","trace[1199707766] 'compare' (duration: 343.404203ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T19:20:05.215125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:20:04.823748Z","time spent":"391.342817ms","remote":"127.0.0.1:37080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-17T19:20:05.215573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.964654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T19:20:05.215621Z","caller":"traceutil/trace.go:171","msg":"trace[452316140] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2027; }","duration":"313.058907ms","start":"2026-09-17T19:20:04.902551Z","end":"2026-09-17T19:20:05.21561Z","steps":["trace[452316140] 'agreement among raft nodes before linearized reading' (duration: 312.963533ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:05.215653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:20:04.902527Z","time spent":"313.117911ms","remote":"127.0.0.1:35730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-09-17T19:20:08.290632Z","caller":"traceutil/trace.go:171","msg":"trace[1359429237] linearizableReadLoop","detail":"{readStateIndex:2134; appliedIndex:2133; }","duration":"105.631179ms","start":"2026-09-17T19:20:08.184978Z","end":"2026-09-17T19:20:08.290609Z","steps":["trace[1359429237] 'read index received' (duration: 105.558716ms)","trace[1359429237] 'applied index is now lower than readState.Index' (duration: 71.423µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:20:08.29071Z","caller":"traceutil/trace.go:171","msg":"trace[1791306701] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"121.047982ms","start":"2026-09-17T19:20:08.169623Z","end":"2026-09-17T19:20:08.290671Z","steps":["trace[1791306701] 'process raft request' (duration: 120.838922ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:08.29093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.915572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-17T19:20:08.290959Z","caller":"traceutil/trace.go:171","msg":"trace[932364075] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2051; }","duration":"106.017128ms","start":"2026-09-17T19:20:08.184931Z","end":"2026-09-17T19:20:08.290949Z","steps":["trace[932364075] 'agreement among raft nodes before linearized reading' (duration: 105.804868ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:20:32.059678Z","caller":"traceutil/trace.go:171","msg":"trace[246874365] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"101.811158ms","start":"2026-09-17T19:20:31.957839Z","end":"2026-09-17T19:20:32.05965Z","steps":["trace[246874365] 'process raft request' (duration: 101.649119ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:20:32.636988Z","caller":"traceutil/trace.go:171","msg":"trace[349367073] linearizableReadLoop","detail":"{readStateIndex:2273; appliedIndex:2272; }","duration":"201.123939ms","start":"2026-09-17T19:20:32.435837Z","end":"2026-09-17T19:20:32.636961Z","steps":["trace[349367073] 'read index received' (duration: 200.847875ms)","trace[349367073] 'applied index is now lower than readState.Index' (duration: 274.984µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:20:32.637058Z","caller":"traceutil/trace.go:171","msg":"trace[338305744] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"209.624349ms","start":"2026-09-17T19:20:32.427402Z","end":"2026-09-17T19:20:32.637026Z","steps":["trace[338305744] 'process raft request' (duration: 209.339065ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:32.637424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.563402ms","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-09-17T19:20:32.637491Z","caller":"traceutil/trace.go:171","msg":"trace[443277407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2184; }","duration":"201.700358ms","start":"2026-09-17T19:20:32.435773Z","end":"2026-09-17T19:20:32.637474Z","steps":["trace[443277407] 'agreement among raft nodes before linearized reading' (duration: 201.281157ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:32.66924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.509636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-09-17T19:20:32.669334Z","caller":"traceutil/trace.go:171","msg":"trace[1264359206] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2185; }","duration":"227.657444ms","start":"2026-09-17T19:20:32.441656Z","end":"2026-09-17T19:20:32.669314Z","steps":["trace[1264359206] 'agreement among raft nodes before linearized reading' (duration: 227.417361ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:32.669497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.501765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-09-17T19:20:32.669543Z","caller":"traceutil/trace.go:171","msg":"trace[1731784669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2185; }","duration":"221.568708ms","start":"2026-09-17T19:20:32.447957Z","end":"2026-09-17T19:20:32.669526Z","steps":["trace[1731784669] 'agreement among raft nodes before linearized reading' (duration: 221.461773ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:32.867555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.416847ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T19:20:32.867845Z","caller":"traceutil/trace.go:171","msg":"trace[1358810003] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2186; }","duration":"114.688142ms","start":"2026-09-17T19:20:32.753108Z","end":"2026-09-17T19:20:32.867796Z","steps":["trace[1358810003] 'range keys from in-memory index tree' (duration: 114.397376ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:20:32.86798Z","caller":"traceutil/trace.go:171","msg":"trace[606617836] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"194.855594ms","start":"2026-09-17T19:20:32.673094Z","end":"2026-09-17T19:20:32.867949Z","steps":["trace[606617836] 'process raft request' (duration: 108.617687ms)","trace[606617836] 'compare' (duration: 85.936131ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:20:32.868375Z","caller":"traceutil/trace.go:171","msg":"trace[1368911549] linearizableReadLoop","detail":"{readStateIndex:2277; appliedIndex:2275; }","duration":"147.012146ms","start":"2026-09-17T19:20:32.72134Z","end":"2026-09-17T19:20:32.868352Z","steps":["trace[1368911549] 'read index received' (duration: 60.382408ms)","trace[1368911549] 'applied index is now lower than readState.Index' (duration: 86.628758ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:20:32.868487Z","caller":"traceutil/trace.go:171","msg":"trace[122182783] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"193.084342ms","start":"2026-09-17T19:20:32.67539Z","end":"2026-09-17T19:20:32.868474Z","steps":["trace[122182783] 'process raft request' (duration: 192.46757ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:32.868624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.283781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T19:20:32.868658Z","caller":"traceutil/trace.go:171","msg":"trace[3692858] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2188; }","duration":"147.358875ms","start":"2026-09-17T19:20:32.721288Z","end":"2026-09-17T19:20:32.868647Z","steps":["trace[3692858] 'agreement among raft nodes before linearized reading' (duration: 147.292191ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:20:32.868752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.681712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-17T19:20:32.868851Z","caller":"traceutil/trace.go:171","msg":"trace[1317891999] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2188; }","duration":"114.797027ms","start":"2026-09-17T19:20:32.754004Z","end":"2026-09-17T19:20:32.868801Z","steps":["trace[1317891999] 'agreement among raft nodes before linearized reading' (duration: 114.625568ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:22:03.191521Z","caller":"traceutil/trace.go:171","msg":"trace[2116675910] transaction","detail":"{read_only:false; response_revision:2766; number_of_response:1; }","duration":"123.451753ms","start":"2026-09-17T19:22:03.068047Z","end":"2026-09-17T19:22:03.191498Z","steps":["trace[2116675910] 'process raft request' (duration: 123.252071ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:22:38.93832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.025412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-17T19:22:38.938476Z","caller":"traceutil/trace.go:171","msg":"trace[750896616] transaction","detail":"{read_only:false; response_revision:2962; number_of_response:1; }","duration":"265.336832ms","start":"2026-09-17T19:22:38.673112Z","end":"2026-09-17T19:22:38.938449Z","steps":["trace[750896616] 'process raft request' (duration: 98.059771ms)","trace[750896616] 'compare' (duration: 166.854612ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:26:34.561999Z","caller":"traceutil/trace.go:171","msg":"trace[1631357372] transaction","detail":"{read_only:false; response_revision:4342; number_of_response:1; }","duration":"115.987225ms","start":"2026-09-17T19:26:34.445991Z","end":"2026-09-17T19:26:34.561978Z","steps":["trace[1631357372] 'process raft request' (duration: 115.914572ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:26:34.562235Z","caller":"traceutil/trace.go:171","msg":"trace[1462659506] transaction","detail":"{read_only:false; response_revision:4341; number_of_response:1; }","duration":"116.430994ms","start":"2026-09-17T19:26:34.44577Z","end":"2026-09-17T19:26:34.562201Z","steps":["trace[1462659506] 'process raft request' (duration: 45.303128ms)","trace[1462659506] 'compare' (duration: 70.635585ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:26:34.782136Z","caller":"traceutil/trace.go:171","msg":"trace[1634749729] transaction","detail":"{read_only:false; response_revision:4345; number_of_response:1; }","duration":"122.102643ms","start":"2026-09-17T19:26:34.660003Z","end":"2026-09-17T19:26:34.782106Z","steps":["trace[1634749729] 'process raft request' (duration: 95.102043ms)","trace[1634749729] 'compare' (duration: 26.583772ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:27:21.529953Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2873} {"level":"info","ts":"2026-09-17T19:27:21.724479Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2873,"took":"193.075028ms","hash":4288971747,"current-db-size-bytes":49303552,"current-db-size":"49 MB","current-db-size-in-use-bytes":25305088,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-09-17T19:27:21.724634Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4288971747,"revision":2873,"compact-revision":-1} {"level":"info","ts":"2026-09-17T19:27:33.974904Z","caller":"traceutil/trace.go:171","msg":"trace[789705391] linearizableReadLoop","detail":"{readStateIndex:5482; appliedIndex:5481; }","duration":"264.255905ms","start":"2026-09-17T19:27:33.710621Z","end":"2026-09-17T19:27:33.974877Z","steps":["trace[789705391] 'read index received' (duration: 226.398488ms)","trace[789705391] 'applied index is now lower than readState.Index' (duration: 37.856117ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:27:33.97496Z","caller":"traceutil/trace.go:171","msg":"trace[1006399887] transaction","detail":"{read_only:false; response_revision:5276; number_of_response:1; }","duration":"303.608603ms","start":"2026-09-17T19:27:33.671303Z","end":"2026-09-17T19:27:33.974911Z","steps":["trace[1006399887] 'process raft request' (duration: 265.693813ms)","trace[1006399887] 'compare' (duration: 37.264039ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T19:27:33.975234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-17T19:27:33.671273Z","time spent":"303.787872ms","remote":"127.0.0.1:36912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-17T19:27:33.975566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.821032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-09-17T19:27:33.975806Z","caller":"traceutil/trace.go:171","msg":"trace[1701262487] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5276; }","duration":"265.175739ms","start":"2026-09-17T19:27:33.710576Z","end":"2026-09-17T19:27:33.975752Z","steps":["trace[1701262487] 'agreement among raft nodes before linearized reading' (duration: 264.536608ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:27:33.976266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.694495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16231"} {"level":"info","ts":"2026-09-17T19:27:33.976337Z","caller":"traceutil/trace.go:171","msg":"trace[169771442] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5276; }","duration":"265.679362ms","start":"2026-09-17T19:27:33.710641Z","end":"2026-09-17T19:27:33.97632Z","steps":["trace[169771442] 'agreement among raft nodes before linearized reading' (duration: 264.475155ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:27:34.176317Z","caller":"traceutil/trace.go:171","msg":"trace[272834137] transaction","detail":"{read_only:false; response_revision:5277; number_of_response:1; }","duration":"192.330647ms","start":"2026-09-17T19:27:33.983955Z","end":"2026-09-17T19:27:34.176285Z","steps":["trace[272834137] 'process raft request' (duration: 157.863958ms)","trace[272834137] 'compare' (duration: 34.328303ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:27:34.201989Z","caller":"traceutil/trace.go:171","msg":"trace[1967173447] linearizableReadLoop","detail":"{readStateIndex:5484; appliedIndex:5482; }","duration":"118.637545ms","start":"2026-09-17T19:27:34.083329Z","end":"2026-09-17T19:27:34.201967Z","steps":["trace[1967173447] 'read index received' (duration: 58.50674ms)","trace[1967173447] 'applied index is now lower than readState.Index' (duration: 60.129635ms)"],"step_count":2} {"level":"warn","ts":"2026-09-17T19:27:34.202223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.878665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-60ef6dfd-8f61-4b56-bd80-33797186efbf\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-17T19:27:34.202265Z","caller":"traceutil/trace.go:171","msg":"trace[1204970941] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-60ef6dfd-8f61-4b56-bd80-33797186efbf; range_end:; response_count:1; response_revision:5278; }","duration":"118.96899ms","start":"2026-09-17T19:27:34.083283Z","end":"2026-09-17T19:27:34.202252Z","steps":["trace[1204970941] 'agreement among raft nodes before linearized reading' (duration: 118.775251ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:27:34.202665Z","caller":"traceutil/trace.go:171","msg":"trace[1582949312] transaction","detail":"{read_only:false; response_revision:5278; number_of_response:1; }","duration":"207.07089ms","start":"2026-09-17T19:27:33.995582Z","end":"2026-09-17T19:27:34.202653Z","steps":["trace[1582949312] 'process raft request' (duration: 206.24438ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:27:34.612067Z","caller":"traceutil/trace.go:171","msg":"trace[1098677158] linearizableReadLoop","detail":"{readStateIndex:5492; appliedIndex:5491; }","duration":"205.692085ms","start":"2026-09-17T19:27:34.40634Z","end":"2026-09-17T19:27:34.612032Z","steps":["trace[1098677158] 'read index received' (duration: 205.502147ms)","trace[1098677158] 'applied index is now lower than readState.Index' (duration: 188.528µs)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:27:34.61213Z","caller":"traceutil/trace.go:171","msg":"trace[365630282] transaction","detail":"{read_only:false; response_revision:5286; number_of_response:1; }","duration":"242.520906ms","start":"2026-09-17T19:27:34.369577Z","end":"2026-09-17T19:27:34.612098Z","steps":["trace[365630282] 'process raft request' (duration: 242.217632ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:27:34.612318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.967498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-09-17T19:27:34.61237Z","caller":"traceutil/trace.go:171","msg":"trace[1961894856] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5286; }","duration":"206.123806ms","start":"2026-09-17T19:27:34.406232Z","end":"2026-09-17T19:27:34.612356Z","steps":["trace[1961894856] 'agreement among raft nodes before linearized reading' (duration: 205.935778ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:27:34.623225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.570756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-17T19:27:34.623294Z","caller":"traceutil/trace.go:171","msg":"trace[1423796705] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5287; }","duration":"173.717363ms","start":"2026-09-17T19:27:34.44956Z","end":"2026-09-17T19:27:34.623278Z","steps":["trace[1423796705] 'agreement among raft nodes before linearized reading' (duration: 173.560316ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:27:46.531079Z","caller":"traceutil/trace.go:171","msg":"trace[1645000174] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"157.843295ms","start":"2026-09-17T19:27:46.373212Z","end":"2026-09-17T19:27:46.531055Z","steps":["trace[1645000174] 'process raft request' (duration: 157.679288ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:27:46.905828Z","caller":"traceutil/trace.go:171","msg":"trace[2040584125] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"214.719156ms","start":"2026-09-17T19:27:46.691074Z","end":"2026-09-17T19:27:46.905793Z","steps":["trace[2040584125] 'process raft request' (duration: 201.712368ms)","trace[2040584125] 'compare' (duration: 12.857601ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:27:46.941713Z","caller":"traceutil/trace.go:171","msg":"trace[789591601] linearizableReadLoop","detail":"{readStateIndex:5648; appliedIndex:5646; }","duration":"234.132529ms","start":"2026-09-17T19:27:46.707534Z","end":"2026-09-17T19:27:46.941667Z","steps":["trace[789591601] 'read index received' (duration: 185.349132ms)","trace[789591601] 'applied index is now lower than readState.Index' (duration: 48.781057ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:27:46.941936Z","caller":"traceutil/trace.go:171","msg":"trace[1941153363] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"250.770028ms","start":"2026-09-17T19:27:46.691145Z","end":"2026-09-17T19:27:46.941915Z","steps":["trace[1941153363] 'process raft request' (duration: 250.280385ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:27:46.942319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.761748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-17T19:27:46.942433Z","caller":"traceutil/trace.go:171","msg":"trace[618144622] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5435; }","duration":"234.919765ms","start":"2026-09-17T19:27:46.707478Z","end":"2026-09-17T19:27:46.942398Z","steps":["trace[618144622] 'agreement among raft nodes before linearized reading' (duration: 234.666413ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:27:46.942835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.45425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10391"} {"level":"info","ts":"2026-09-17T19:27:46.942907Z","caller":"traceutil/trace.go:171","msg":"trace[1842934198] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:5435; }","duration":"100.605638ms","start":"2026-09-17T19:27:46.842285Z","end":"2026-09-17T19:27:46.942891Z","steps":["trace[1842934198] 'agreement among raft nodes before linearized reading' (duration: 99.668753ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:27:47.171639Z","caller":"traceutil/trace.go:171","msg":"trace[913553864] transaction","detail":"{read_only:false; response_revision:5443; number_of_response:1; }","duration":"108.044256ms","start":"2026-09-17T19:27:47.063534Z","end":"2026-09-17T19:27:47.171578Z","steps":["trace[913553864] 'process raft request' (duration: 83.353722ms)","trace[913553864] 'compare' (duration: 24.40686ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:31:21.025598Z","caller":"traceutil/trace.go:171","msg":"trace[2104042226] transaction","detail":"{read_only:false; response_revision:7014; number_of_response:1; }","duration":"167.085064ms","start":"2026-09-17T19:31:20.858448Z","end":"2026-09-17T19:31:21.025533Z","steps":["trace[2104042226] 'process raft request' (duration: 134.31597ms)","trace[2104042226] 'compare' (duration: 32.552423ms)"],"step_count":2} {"level":"info","ts":"2026-09-17T19:31:37.357355Z","caller":"traceutil/trace.go:171","msg":"trace[819626590] transaction","detail":"{read_only:false; response_revision:7124; number_of_response:1; }","duration":"107.597457ms","start":"2026-09-17T19:31:37.249734Z","end":"2026-09-17T19:31:37.357331Z","steps":["trace[819626590] 'process raft request' (duration: 107.200974ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:31:42.567586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.75868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-09-17T19:31:42.567671Z","caller":"traceutil/trace.go:171","msg":"trace[1947850552] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7181; }","duration":"138.8896ms","start":"2026-09-17T19:31:42.428763Z","end":"2026-09-17T19:31:42.567652Z","steps":["trace[1947850552] 'range keys from in-memory index tree' (duration: 138.594669ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:31:42.567868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.432999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-17T19:31:42.567902Z","caller":"traceutil/trace.go:171","msg":"trace[234286267] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:7181; }","duration":"132.501219ms","start":"2026-09-17T19:31:42.435392Z","end":"2026-09-17T19:31:42.567893Z","steps":["trace[234286267] 'count revisions from in-memory index tree' (duration: 132.387099ms)"],"step_count":1} {"level":"warn","ts":"2026-09-17T19:31:42.568151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.477412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-17T19:31:42.568184Z","caller":"traceutil/trace.go:171","msg":"trace[1038019007] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7181; }","duration":"110.539853ms","start":"2026-09-17T19:31:42.457636Z","end":"2026-09-17T19:31:42.568176Z","steps":["trace[1038019007] 'range keys from in-memory index tree' (duration: 110.367062ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:31:49.759648Z","caller":"traceutil/trace.go:171","msg":"trace[501319310] transaction","detail":"{read_only:false; response_revision:7217; number_of_response:1; }","duration":"131.935552ms","start":"2026-09-17T19:31:49.627686Z","end":"2026-09-17T19:31:49.759622Z","steps":["trace[501319310] 'process raft request' (duration: 131.793011ms)"],"step_count":1} {"level":"info","ts":"2026-09-17T19:32:21.539032Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":4968} {"level":"info","ts":"2026-09-17T19:32:21.623718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":4968,"took":"83.019061ms","hash":2148449995,"current-db-size-bytes":49303552,"current-db-size":"49 MB","current-db-size-in-use-bytes":19599360,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-09-17T19:32:21.62379Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2148449995,"revision":4968,"compact-revision":2873}