{"level":"warn","ts":"2026-05-01T14:10:10.257953Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-01T14:10:10.258088Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-01T14:10:10.258187Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-01T14:10:10.258254Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-01T14:10:10.258287Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-01T14:10:10.259083Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-05-01T14:10:10.259178Z","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://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-01T14:10:10.263526Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.946158ms"} {"level":"info","ts":"2026-05-01T14:10:10.269748Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-05-01T14:10:10.269978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-05-01T14:10:10.270063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-05-01T14:10:10.270135Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-01T14:10:10.271089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-05-01T14:10:10.271217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-05-01T14:10:10.284659Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-01T14:10:10.286648Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-01T14:10:10.288239Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-01T14:10:10.29124Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-01T14:10:10.291417Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-01T14:10:10.291732Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-01T14:10:10.291873Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-01T14:10:10.291974Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-01T14:10:10.294271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-05-01T14:10:10.294553Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-05-01T14:10:10.297036Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-01T14:10:10.297237Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-01T14:10:10.297295Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-05-01T14:10:10.297473Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-01T14:10:10.297519Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-01T14:10:10.372097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-05-01T14:10:10.372157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-05-01T14:10:10.372198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-05-01T14:10:10.37222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-05-01T14:10:10.372388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-01T14:10:10.372482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-05-01T14:10:10.372508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-05-01T14:10:10.373497Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T14:10:10.374441Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-01T14:10:10.374431Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-05-01T14:10:10.374519Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-01T14:10:10.374737Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-01T14:10:10.374779Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-01T14:10:10.374904Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T14:10:10.375039Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T14:10:10.375086Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-01T14:10:10.379112Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-01T14:10:10.379457Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"warn","ts":"2026-05-01T14:10:45.52226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.147678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-01T14:10:45.522463Z","caller":"traceutil/trace.go:171","msg":"trace[610715603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"113.404475ms","start":"2026-05-01T14:10:45.409034Z","end":"2026-05-01T14:10:45.522438Z","steps":["trace[610715603] 'range keys from in-memory index tree' (duration: 112.938282ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:10:45.79264Z","caller":"traceutil/trace.go:171","msg":"trace[1084073930] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"316.511092ms","start":"2026-05-01T14:10:45.476105Z","end":"2026-05-01T14:10:45.792616Z","steps":["trace[1084073930] 'read index received' (duration: 315.821534ms)","trace[1084073930] 'applied index is now lower than readState.Index' (duration: 688.348µs)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:10:45.792696Z","caller":"traceutil/trace.go:171","msg":"trace[309600067] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"354.776733ms","start":"2026-05-01T14:10:45.43789Z","end":"2026-05-01T14:10:45.792667Z","steps":["trace[309600067] 'process raft request' (duration: 354.151526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:10:45.792933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.806051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-01T14:10:45.793042Z","caller":"traceutil/trace.go:171","msg":"trace[1982921441] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"316.960375ms","start":"2026-05-01T14:10:45.476054Z","end":"2026-05-01T14:10:45.793014Z","steps":["trace[1982921441] 'agreement among raft nodes before linearized reading' (duration: 316.671237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:10:45.793094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:45.476033Z","time spent":"317.050748ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-01T14:10:45.793646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:45.437854Z","time spent":"355.034821ms","remote":"127.0.0.1:35234","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:10:46.11701Z","caller":"traceutil/trace.go:171","msg":"trace[321894215] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"412.367604ms","start":"2026-05-01T14:10:45.70462Z","end":"2026-05-01T14:10:46.116987Z","steps":["trace[321894215] 'process raft request' (duration: 412.307302ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:10:46.117036Z","caller":"traceutil/trace.go:171","msg":"trace[1542274628] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"589.732464ms","start":"2026-05-01T14:10:45.527271Z","end":"2026-05-01T14:10:46.117004Z","steps":["trace[1542274628] 'process raft request' (duration: 536.116942ms)","trace[1542274628] 'compare' (duration: 53.397826ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T14:10:46.117166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:45.704592Z","time spent":"412.497187ms","remote":"127.0.0.1:35334","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:10:46.117185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:45.527246Z","time spent":"589.862847ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:10:46.643048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.005777ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-01T14:10:46.643295Z","caller":"traceutil/trace.go:171","msg":"trace[694018524] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:605; }","duration":"452.30922ms","start":"2026-05-01T14:10:46.190952Z","end":"2026-05-01T14:10:46.643261Z","steps":["trace[694018524] 'read index received' (duration: 301.157629ms)","trace[694018524] 'applied index is now lower than readState.Index' (duration: 151.150951ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:10:46.643301Z","caller":"traceutil/trace.go:171","msg":"trace[1752449305] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"796.472361ms","start":"2026-05-01T14:10:45.846803Z","end":"2026-05-01T14:10:46.643276Z","steps":["trace[1752449305] 'process raft request' (duration: 796.323917ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:10:46.643368Z","caller":"traceutil/trace.go:171","msg":"trace[260483610] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"743.008283ms","start":"2026-05-01T14:10:45.900352Z","end":"2026-05-01T14:10:46.64336Z","steps":["trace[260483610] 'process raft request' (duration: 742.837868ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:10:46.643354Z","caller":"traceutil/trace.go:171","msg":"trace[104839247] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"846.29527ms","start":"2026-05-01T14:10:45.797029Z","end":"2026-05-01T14:10:46.643324Z","steps":["trace[104839247] 'process raft request' (duration: 694.82354ms)","trace[104839247] 'compare' (duration: 150.577505ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T14:10:46.643429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:45.846782Z","time spent":"796.577804ms","remote":"127.0.0.1:35670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-01T14:10:46.643598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:45.797009Z","time spent":"846.439144ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:10:46.643442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:45.900325Z","time spent":"743.089785ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:10:46.643645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.686201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-01T14:10:46.643697Z","caller":"traceutil/trace.go:171","msg":"trace[40289700] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:581; }","duration":"452.782643ms","start":"2026-05-01T14:10:46.190901Z","end":"2026-05-01T14:10:46.643684Z","steps":["trace[40289700] 'agreement among raft nodes before linearized reading' (duration: 452.621279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:10:46.643733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:10:46.190879Z","time spent":"452.846114ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-01T14:10:46.644054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.221438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-01T14:10:46.644172Z","caller":"traceutil/trace.go:171","msg":"trace[1719510486] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:581; }","duration":"133.364051ms","start":"2026-05-01T14:10:46.510765Z","end":"2026-05-01T14:10:46.644129Z","steps":["trace[1719510486] 'agreement among raft nodes before linearized reading' (duration: 133.094974ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:11:04.144161Z","caller":"traceutil/trace.go:171","msg":"trace[1816244728] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"129.760074ms","start":"2026-05-01T14:11:04.014374Z","end":"2026-05-01T14:11:04.144134Z","steps":["trace[1816244728] 'process raft request' (duration: 129.60804ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:12:16.773865Z","caller":"traceutil/trace.go:171","msg":"trace[478767319] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"180.09454ms","start":"2026-05-01T14:12:16.59374Z","end":"2026-05-01T14:12:16.773835Z","steps":["trace[478767319] 'process raft request' (duration: 106.595973ms)","trace[478767319] 'compare' (duration: 73.215219ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:12:16.774011Z","caller":"traceutil/trace.go:171","msg":"trace[1002314154] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"179.495343ms","start":"2026-05-01T14:12:16.59448Z","end":"2026-05-01T14:12:16.773975Z","steps":["trace[1002314154] 'process raft request' (duration: 179.228396ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:12:25.077475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.856872ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-01T14:12:25.077605Z","caller":"traceutil/trace.go:171","msg":"trace[1309533468] linearizableReadLoop","detail":"{readStateIndex:1949; appliedIndex:1948; }","duration":"137.019396ms","start":"2026-05-01T14:12:24.940564Z","end":"2026-05-01T14:12:25.077584Z","steps":["trace[1309533468] 'read index received' (duration: 21.745423ms)","trace[1309533468] 'applied index is now lower than readState.Index' (duration: 115.272783ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:12:25.077702Z","caller":"traceutil/trace.go:171","msg":"trace[2085337325] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"181.136849ms","start":"2026-05-01T14:12:24.896527Z","end":"2026-05-01T14:12:25.077664Z","steps":["trace[2085337325] 'process raft request' (duration: 65.823604ms)","trace[2085337325] 'compare' (duration: 114.726019ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T14:12:25.077804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.849709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-05-01T14:12:25.077814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.243982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11981"} {"level":"info","ts":"2026-05-01T14:12:25.077914Z","caller":"traceutil/trace.go:171","msg":"trace[918182198] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1876; }","duration":"137.396316ms","start":"2026-05-01T14:12:24.9405Z","end":"2026-05-01T14:12:25.077897Z","steps":["trace[918182198] 'agreement among raft nodes before linearized reading' (duration: 137.16501ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:12:25.07784Z","caller":"traceutil/trace.go:171","msg":"trace[837675082] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1876; }","duration":"128.915301ms","start":"2026-05-01T14:12:24.948912Z","end":"2026-05-01T14:12:25.077827Z","steps":["trace[837675082] 'agreement among raft nodes before linearized reading' (duration: 128.776037ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:13:01.302789Z","caller":"traceutil/trace.go:171","msg":"trace[1848202555] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"109.106751ms","start":"2026-05-01T14:13:01.19366Z","end":"2026-05-01T14:13:01.302766Z","steps":["trace[1848202555] 'process raft request' (duration: 108.917216ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:13:01.767003Z","caller":"traceutil/trace.go:171","msg":"trace[1521882633] transaction","detail":"{read_only:false; response_revision:2096; number_of_response:1; }","duration":"115.16229ms","start":"2026-05-01T14:13:01.65179Z","end":"2026-05-01T14:13:01.766952Z","steps":["trace[1521882633] 'process raft request' (duration: 90.534773ms)","trace[1521882633] 'compare' (duration: 24.239916ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:13:55.980963Z","caller":"traceutil/trace.go:171","msg":"trace[1526255170] transaction","detail":"{read_only:false; response_revision:2561; number_of_response:1; }","duration":"136.225381ms","start":"2026-05-01T14:13:55.844715Z","end":"2026-05-01T14:13:55.98094Z","steps":["trace[1526255170] 'process raft request' (duration: 136.074927ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:13:55.990249Z","caller":"traceutil/trace.go:171","msg":"trace[1776596063] transaction","detail":"{read_only:false; response_revision:2562; number_of_response:1; }","duration":"125.802811ms","start":"2026-05-01T14:13:55.864419Z","end":"2026-05-01T14:13:55.990222Z","steps":["trace[1776596063] 'process raft request' (duration: 125.239934ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:14:29.837366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.926122ms","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-05-01T14:14:29.837463Z","caller":"traceutil/trace.go:171","msg":"trace[736323603] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2762; }","duration":"104.073416ms","start":"2026-05-01T14:14:29.733367Z","end":"2026-05-01T14:14:29.83744Z","steps":["trace[736323603] 'range keys from in-memory index tree' (duration: 103.655904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:14:30.155086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.33894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-01T14:14:30.155152Z","caller":"traceutil/trace.go:171","msg":"trace[153008182] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:2766; }","duration":"198.479463ms","start":"2026-05-01T14:14:29.956659Z","end":"2026-05-01T14:14:30.155138Z","steps":["trace[153008182] 'count revisions from in-memory index tree' (duration: 198.241426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:14:30.155179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.705846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-01T14:14:30.155325Z","caller":"traceutil/trace.go:171","msg":"trace[1320208362] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2766; }","duration":"167.907182ms","start":"2026-05-01T14:14:29.987395Z","end":"2026-05-01T14:14:30.155302Z","steps":["trace[1320208362] 'range keys from in-memory index tree' (duration: 167.483341ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:14:30.254106Z","caller":"traceutil/trace.go:171","msg":"trace[2129359275] transaction","detail":"{read_only:false; response_revision:2767; number_of_response:1; }","duration":"110.585097ms","start":"2026-05-01T14:14:30.143488Z","end":"2026-05-01T14:14:30.254073Z","steps":["trace[2129359275] 'process raft request' (duration: 110.203026ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:21.682753Z","caller":"traceutil/trace.go:171","msg":"trace[2061631210] linearizableReadLoop","detail":"{readStateIndex:5085; appliedIndex:5083; }","duration":"154.801331ms","start":"2026-05-01T14:18:21.527931Z","end":"2026-05-01T14:18:21.682732Z","steps":["trace[2061631210] 'read index received' (duration: 86.608159ms)","trace[2061631210] 'applied index is now lower than readState.Index' (duration: 68.192342ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:18:21.683043Z","caller":"traceutil/trace.go:171","msg":"trace[112331834] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"158.464253ms","start":"2026-05-01T14:18:21.52435Z","end":"2026-05-01T14:18:21.682815Z","steps":["trace[112331834] 'process raft request' (duration: 158.279398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:21.683105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.159222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/vector\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-05-01T14:18:21.683126Z","caller":"traceutil/trace.go:171","msg":"trace[766337900] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/vector; range_end:; response_count:1; response_revision:4898; }","duration":"155.214023ms","start":"2026-05-01T14:18:21.527907Z","end":"2026-05-01T14:18:21.683121Z","steps":["trace[766337900] 'agreement among raft nodes before linearized reading' (duration: 154.928795ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:23.801467Z","caller":"traceutil/trace.go:171","msg":"trace[382786300] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"160.044417ms","start":"2026-05-01T14:18:23.641397Z","end":"2026-05-01T14:18:23.801442Z","steps":["trace[382786300] 'process raft request' (duration: 159.904233ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:23.807776Z","caller":"traceutil/trace.go:171","msg":"trace[2096382684] linearizableReadLoop","detail":"{readStateIndex:5148; appliedIndex:5146; }","duration":"104.605193ms","start":"2026-05-01T14:18:23.703142Z","end":"2026-05-01T14:18:23.807747Z","steps":["trace[2096382684] 'read index received' (duration: 98.130112ms)","trace[2096382684] 'applied index is now lower than readState.Index' (duration: 6.473771ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T14:18:23.808033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.86086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-81533c72-0e3e-4d2b-a513-74c19b0f7b3a\" ","response":"range_response_count:1 size:3907"} {"level":"info","ts":"2026-05-01T14:18:23.808078Z","caller":"traceutil/trace.go:171","msg":"trace[749935060] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-81533c72-0e3e-4d2b-a513-74c19b0f7b3a; range_end:; response_count:1; response_revision:4959; }","duration":"104.948192ms","start":"2026-05-01T14:18:23.703116Z","end":"2026-05-01T14:18:23.808064Z","steps":["trace[749935060] 'agreement among raft nodes before linearized reading' (duration: 104.767687ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:31.782359Z","caller":"traceutil/trace.go:171","msg":"trace[1591714455] transaction","detail":"{read_only:false; response_revision:5109; number_of_response:1; }","duration":"102.69486ms","start":"2026-05-01T14:18:31.679637Z","end":"2026-05-01T14:18:31.782332Z","steps":["trace[1591714455] 'process raft request' (duration: 83.722238ms)","trace[1591714455] 'compare' (duration: 18.778997ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:18:31.782621Z","caller":"traceutil/trace.go:171","msg":"trace[429168126] transaction","detail":"{read_only:false; response_revision:5110; number_of_response:1; }","duration":"102.769552ms","start":"2026-05-01T14:18:31.679819Z","end":"2026-05-01T14:18:31.782588Z","steps":["trace[429168126] 'process raft request' (duration: 102.451533ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:31.782665Z","caller":"traceutil/trace.go:171","msg":"trace[1363074624] transaction","detail":"{read_only:false; response_revision:5111; number_of_response:1; }","duration":"102.820373ms","start":"2026-05-01T14:18:31.679818Z","end":"2026-05-01T14:18:31.782638Z","steps":["trace[1363074624] 'process raft request' (duration: 102.69477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.223995Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828355489206089,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-01T14:18:51.724874Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828355489206089,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-01T14:18:51.789308Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.647214038s","expected-duration":"1s"} {"level":"info","ts":"2026-05-01T14:18:51.78968Z","caller":"traceutil/trace.go:171","msg":"trace[829984729] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"1.647711972s","start":"2026-05-01T14:18:50.141945Z","end":"2026-05-01T14:18:51.789657Z","steps":["trace[829984729] 'process raft request' (duration: 1.647588008s)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.789816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.141922Z","time spent":"1.647815095s","remote":"127.0.0.1:35346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17194,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:18:51.790737Z","caller":"traceutil/trace.go:171","msg":"trace[1878834512] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"566.362581ms","start":"2026-05-01T14:18:51.224356Z","end":"2026-05-01T14:18:51.790719Z","steps":["trace[1878834512] 'process raft request' (duration: 566.270219ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.790846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.224348Z","time spent":"566.446103ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:18:51.790905Z","caller":"traceutil/trace.go:171","msg":"trace[1143669658] linearizableReadLoop","detail":"{readStateIndex:5634; appliedIndex:5630; }","duration":"1.627410134s","start":"2026-05-01T14:18:50.163471Z","end":"2026-05-01T14:18:51.790881Z","steps":["trace[1143669658] 'read index received' (duration: 1.626164569s)","trace[1143669658] 'applied index is now lower than readState.Index' (duration: 1.244425ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:18:51.791146Z","caller":"traceutil/trace.go:171","msg":"trace[947993832] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"408.817873ms","start":"2026-05-01T14:18:51.382311Z","end":"2026-05-01T14:18:51.791129Z","steps":["trace[947993832] 'process raft request' (duration: 408.364041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.791228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.382289Z","time spent":"408.895165ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:18:51.791339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.510164426s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-01T14:18:51.791322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.627815834s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-05-01T14:18:51.791395Z","caller":"traceutil/trace.go:171","msg":"trace[2133894729] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:5435; }","duration":"1.510249957s","start":"2026-05-01T14:18:50.28113Z","end":"2026-05-01T14:18:51.79138Z","steps":["trace[2133894729] 'agreement among raft nodes before linearized reading' (duration: 1.510096523s)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.791441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.281119Z","time spent":"1.510309021s","remote":"127.0.0.1:35366","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":78,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"info","ts":"2026-05-01T14:18:51.791428Z","caller":"traceutil/trace.go:171","msg":"trace[525991013] 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:5435; }","duration":"1.62798418s","start":"2026-05-01T14:18:50.163414Z","end":"2026-05-01T14:18:51.791398Z","steps":["trace[525991013] 'agreement among raft nodes before linearized reading' (duration: 1.627642759s)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.791545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.163393Z","time spent":"1.628133164s","remote":"127.0.0.1:35310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"info","ts":"2026-05-01T14:18:51.790784Z","caller":"traceutil/trace.go:171","msg":"trace[911427241] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"566.829224ms","start":"2026-05-01T14:18:51.223929Z","end":"2026-05-01T14:18:51.790758Z","steps":["trace[911427241] 'process raft request' (duration: 566.584537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.79176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.223918Z","time spent":"567.72821ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:18:51.791798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.149299ms","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-05-01T14:18:51.791856Z","caller":"traceutil/trace.go:171","msg":"trace[604507826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5435; }","duration":"406.21459ms","start":"2026-05-01T14:18:51.385628Z","end":"2026-05-01T14:18:51.791842Z","steps":["trace[604507826] 'agreement among raft nodes before linearized reading' (duration: 406.036655ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.791904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.385624Z","time spent":"406.268752ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-01T14:18:51.792034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.738701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-01T14:18:51.791976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.357006ms","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-05-01T14:18:51.792132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.599301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-01T14:18:51.792174Z","caller":"traceutil/trace.go:171","msg":"trace[1229766072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5435; }","duration":"405.602904ms","start":"2026-05-01T14:18:51.386504Z","end":"2026-05-01T14:18:51.792107Z","steps":["trace[1229766072] 'agreement among raft nodes before linearized reading' (duration: 404.932045ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.79223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.959234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-05-01T14:18:51.792242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.642953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-01T14:18:51.792261Z","caller":"traceutil/trace.go:171","msg":"trace[1451301687] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5435; }","duration":"375.028006ms","start":"2026-05-01T14:18:51.417227Z","end":"2026-05-01T14:18:51.792255Z","steps":["trace[1451301687] 'agreement among raft nodes before linearized reading' (duration: 374.918543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.792295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.417204Z","time spent":"375.079177ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-05-01T14:18:51.792288Z","caller":"traceutil/trace.go:171","msg":"trace[1142262609] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5435; }","duration":"559.707814ms","start":"2026-05-01T14:18:51.232569Z","end":"2026-05-01T14:18:51.792277Z","steps":["trace[1142262609] 'agreement among raft nodes before linearized reading' (duration: 559.642872ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.792285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.386482Z","time spent":"405.739787ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-01T14:18:51.792402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.387535066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-01T14:18:51.792435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.682106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3243"} {"level":"warn","ts":"2026-05-01T14:18:51.792414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.263944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cdjtp\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-01T14:18:51.792451Z","caller":"traceutil/trace.go:171","msg":"trace[904869264] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5435; }","duration":"1.387605729s","start":"2026-05-01T14:18:50.404834Z","end":"2026-05-01T14:18:51.792439Z","steps":["trace[904869264] 'agreement among raft nodes before linearized reading' (duration: 1.387519906s)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:51.792477Z","caller":"traceutil/trace.go:171","msg":"trace[512874894] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cdjtp; range_end:; response_count:1; response_revision:5435; }","duration":"405.327395ms","start":"2026-05-01T14:18:51.387134Z","end":"2026-05-01T14:18:51.792461Z","steps":["trace[512874894] 'agreement among raft nodes before linearized reading' (duration: 405.164181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.792496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:50.404823Z","time spent":"1.38766065s","remote":"127.0.0.1:35578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":30,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-05-01T14:18:51.792536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.816595ms","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-05-01T14:18:51.792457Z","caller":"traceutil/trace.go:171","msg":"trace[1835013226] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5435; }","duration":"568.699967ms","start":"2026-05-01T14:18:51.223748Z","end":"2026-05-01T14:18:51.792448Z","steps":["trace[1835013226] 'agreement among raft nodes before linearized reading' (duration: 568.602224ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:51.792577Z","caller":"traceutil/trace.go:171","msg":"trace[1483328675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5435; }","duration":"565.874667ms","start":"2026-05-01T14:18:51.226697Z","end":"2026-05-01T14:18:51.792572Z","steps":["trace[1483328675] 'agreement among raft nodes before linearized reading' (duration: 565.781405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.792598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.226685Z","time spent":"565.908358ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-01T14:18:51.792307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.822391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2319"} {"level":"info","ts":"2026-05-01T14:18:51.792671Z","caller":"traceutil/trace.go:171","msg":"trace[1955130238] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5435; }","duration":"252.220442ms","start":"2026-05-01T14:18:51.540434Z","end":"2026-05-01T14:18:51.792654Z","steps":["trace[1955130238] 'agreement among raft nodes before linearized reading' (duration: 251.770009ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.792719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.722407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-01T14:18:51.792539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.387113Z","time spent":"405.413678ms","remote":"127.0.0.1:35346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-cdjtp\" "} {"level":"info","ts":"2026-05-01T14:18:51.792904Z","caller":"traceutil/trace.go:171","msg":"trace[1363003762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5435; }","duration":"568.915792ms","start":"2026-05-01T14:18:51.22397Z","end":"2026-05-01T14:18:51.792886Z","steps":["trace[1363003762] 'agreement among raft nodes before linearized reading' (duration: 568.549222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.792594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.223711Z","time spent":"568.871002ms","remote":"127.0.0.1:53178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3266,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" "} {"level":"warn","ts":"2026-05-01T14:18:51.793023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.223967Z","time spent":"569.037696ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-01T14:18:51.792187Z","caller":"traceutil/trace.go:171","msg":"trace[1010506719] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5435; }","duration":"406.682483ms","start":"2026-05-01T14:18:51.385491Z","end":"2026-05-01T14:18:51.792174Z","steps":["trace[1010506719] 'agreement among raft nodes before linearized reading' (duration: 406.55659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.793196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.385477Z","time spent":"407.709291ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-01T14:18:51.792071Z","caller":"traceutil/trace.go:171","msg":"trace[1111247835] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:5435; }","duration":"117.842214ms","start":"2026-05-01T14:18:51.674217Z","end":"2026-05-01T14:18:51.792059Z","steps":["trace[1111247835] 'agreement among raft nodes before linearized reading' (duration: 117.733441ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:51.792331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:18:51.232552Z","time spent":"559.768696ms","remote":"127.0.0.1:35142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-01T14:18:56.14701Z","caller":"traceutil/trace.go:171","msg":"trace[90871] transaction","detail":"{read_only:false; response_revision:5477; number_of_response:1; }","duration":"271.229586ms","start":"2026-05-01T14:18:55.875753Z","end":"2026-05-01T14:18:56.146983Z","steps":["trace[90871] 'process raft request' (duration: 260.610058ms)","trace[90871] 'compare' (duration: 10.251097ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:18:56.150017Z","caller":"traceutil/trace.go:171","msg":"trace[333701287] transaction","detail":"{read_only:false; response_revision:5478; number_of_response:1; }","duration":"273.824067ms","start":"2026-05-01T14:18:55.876177Z","end":"2026-05-01T14:18:56.150001Z","steps":["trace[333701287] 'process raft request' (duration: 273.712114ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:56.150321Z","caller":"traceutil/trace.go:171","msg":"trace[1279507961] transaction","detail":"{read_only:false; response_revision:5479; number_of_response:1; }","duration":"274.120206ms","start":"2026-05-01T14:18:55.876188Z","end":"2026-05-01T14:18:56.150308Z","steps":["trace[1279507961] 'process raft request' (duration: 273.781266ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:56.150526Z","caller":"traceutil/trace.go:171","msg":"trace[1910856773] linearizableReadLoop","detail":"{readStateIndex:5679; appliedIndex:5676; }","duration":"273.971372ms","start":"2026-05-01T14:18:55.8765Z","end":"2026-05-01T14:18:56.150471Z","steps":["trace[1910856773] 'read index received' (duration: 259.966259ms)","trace[1910856773] 'applied index is now lower than readState.Index' (duration: 14.004203ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:18:56.150672Z","caller":"traceutil/trace.go:171","msg":"trace[546781685] transaction","detail":"{read_only:false; response_revision:5482; number_of_response:1; }","duration":"273.49226ms","start":"2026-05-01T14:18:55.877142Z","end":"2026-05-01T14:18:56.150634Z","steps":["trace[546781685] 'process raft request' (duration: 273.256483ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:56.150682Z","caller":"traceutil/trace.go:171","msg":"trace[221306028] transaction","detail":"{read_only:false; response_revision:5481; number_of_response:1; }","duration":"273.985873ms","start":"2026-05-01T14:18:55.876646Z","end":"2026-05-01T14:18:56.150632Z","steps":["trace[221306028] 'process raft request' (duration: 273.703934ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:56.15099Z","caller":"traceutil/trace.go:171","msg":"trace[113455400] transaction","detail":"{read_only:false; response_revision:5480; number_of_response:1; }","duration":"274.404575ms","start":"2026-05-01T14:18:55.876567Z","end":"2026-05-01T14:18:56.150972Z","steps":["trace[113455400] 'process raft request' (duration: 273.630523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:18:56.151209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.657252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:9 size:81491"} {"level":"info","ts":"2026-05-01T14:18:56.151269Z","caller":"traceutil/trace.go:171","msg":"trace[1686968985] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:9; response_revision:5482; }","duration":"274.788135ms","start":"2026-05-01T14:18:55.876455Z","end":"2026-05-01T14:18:56.151243Z","steps":["trace[1686968985] 'agreement among raft nodes before linearized reading' (duration: 274.401685ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:18:56.463207Z","caller":"traceutil/trace.go:171","msg":"trace[220227870] transaction","detail":"{read_only:false; response_revision:5489; number_of_response:1; }","duration":"113.386079ms","start":"2026-05-01T14:18:56.349796Z","end":"2026-05-01T14:18:56.463182Z","steps":["trace[220227870] 'process raft request' (duration: 113.246785ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:20:10.648718Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2987} {"level":"info","ts":"2026-05-01T14:20:10.716599Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2987,"took":"66.618993ms","hash":3780293904,"current-db-size-bytes":57544704,"current-db-size":"58 MB","current-db-size-in-use-bytes":34029568,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-05-01T14:20:10.716713Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3780293904,"revision":2987,"compact-revision":-1} {"level":"info","ts":"2026-05-01T14:24:42.096616Z","caller":"traceutil/trace.go:171","msg":"trace[1043128251] linearizableReadLoop","detail":"{readStateIndex:8396; appliedIndex:8395; }","duration":"230.843347ms","start":"2026-05-01T14:24:41.86575Z","end":"2026-05-01T14:24:42.096593Z","steps":["trace[1043128251] 'read index received' (duration: 230.686352ms)","trace[1043128251] 'applied index is now lower than readState.Index' (duration: 155.735µs)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:24:42.096761Z","caller":"traceutil/trace.go:171","msg":"trace[1824683716] transaction","detail":"{read_only:false; response_revision:8113; number_of_response:1; }","duration":"231.98314ms","start":"2026-05-01T14:24:41.864722Z","end":"2026-05-01T14:24:42.096705Z","steps":["trace[1824683716] 'process raft request' (duration: 231.718821ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:24:42.096845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.072464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-01T14:24:42.096888Z","caller":"traceutil/trace.go:171","msg":"trace[713812027] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8113; }","duration":"231.152466ms","start":"2026-05-01T14:24:41.865726Z","end":"2026-05-01T14:24:42.096878Z","steps":["trace[713812027] 'agreement among raft nodes before linearized reading' (duration: 230.998912ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:24:42.096969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.528199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-01T14:24:42.097039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.394542ms","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-05-01T14:24:42.097062Z","caller":"traceutil/trace.go:171","msg":"trace[940447346] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8113; }","duration":"230.664753ms","start":"2026-05-01T14:24:41.866373Z","end":"2026-05-01T14:24:42.097038Z","steps":["trace[940447346] 'agreement among raft nodes before linearized reading' (duration: 230.439237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:24:42.097074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.385384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-01T14:24:42.097094Z","caller":"traceutil/trace.go:171","msg":"trace[1062052031] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8113; }","duration":"209.481615ms","start":"2026-05-01T14:24:41.887597Z","end":"2026-05-01T14:24:42.097079Z","steps":["trace[1062052031] 'agreement among raft nodes before linearized reading' (duration: 209.341721ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:42.097142Z","caller":"traceutil/trace.go:171","msg":"trace[1874898866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8113; }","duration":"203.492416ms","start":"2026-05-01T14:24:41.893631Z","end":"2026-05-01T14:24:42.097124Z","steps":["trace[1874898866] 'agreement among raft nodes before linearized reading' (duration: 203.26652ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:42.275159Z","caller":"traceutil/trace.go:171","msg":"trace[1990712543] transaction","detail":"{read_only:false; response_revision:8114; number_of_response:1; }","duration":"174.243181ms","start":"2026-05-01T14:24:42.100874Z","end":"2026-05-01T14:24:42.275117Z","steps":["trace[1990712543] 'process raft request' (duration: 174.098597ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:42.276087Z","caller":"traceutil/trace.go:171","msg":"trace[1093805518] transaction","detail":"{read_only:false; response_revision:8116; number_of_response:1; }","duration":"174.949202ms","start":"2026-05-01T14:24:42.101109Z","end":"2026-05-01T14:24:42.276058Z","steps":["trace[1093805518] 'process raft request' (duration: 174.834359ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:42.276203Z","caller":"traceutil/trace.go:171","msg":"trace[537469413] transaction","detail":"{read_only:false; response_revision:8117; number_of_response:1; }","duration":"175.075736ms","start":"2026-05-01T14:24:42.101112Z","end":"2026-05-01T14:24:42.276188Z","steps":["trace[537469413] 'process raft request' (duration: 174.900111ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:42.27633Z","caller":"traceutil/trace.go:171","msg":"trace[29131512] transaction","detail":"{read_only:false; response_revision:8115; number_of_response:1; }","duration":"175.206589ms","start":"2026-05-01T14:24:42.1011Z","end":"2026-05-01T14:24:42.276307Z","steps":["trace[29131512] 'process raft request' (duration: 174.663753ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:54.575872Z","caller":"traceutil/trace.go:171","msg":"trace[634025535] transaction","detail":"{read_only:false; response_revision:8174; number_of_response:1; }","duration":"237.937798ms","start":"2026-05-01T14:24:54.337908Z","end":"2026-05-01T14:24:54.575846Z","steps":["trace[634025535] 'process raft request' (duration: 237.788103ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:54.641133Z","caller":"traceutil/trace.go:171","msg":"trace[157857371] transaction","detail":"{read_only:false; response_revision:8175; number_of_response:1; }","duration":"302.843137ms","start":"2026-05-01T14:24:54.338269Z","end":"2026-05-01T14:24:54.641112Z","steps":["trace[157857371] 'process raft request' (duration: 302.682322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:24:54.641263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:24:54.338259Z","time spent":"302.93216ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:24:54.64143Z","caller":"traceutil/trace.go:171","msg":"trace[2031932116] transaction","detail":"{read_only:false; response_revision:8176; number_of_response:1; }","duration":"303.087254ms","start":"2026-05-01T14:24:54.338319Z","end":"2026-05-01T14:24:54.641406Z","steps":["trace[2031932116] 'process raft request' (duration: 302.759204ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:24:54.641574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:24:54.338303Z","time spent":"303.190937ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:24:54.641637Z","caller":"traceutil/trace.go:171","msg":"trace[1677186396] transaction","detail":"{read_only:false; response_revision:8177; number_of_response:1; }","duration":"301.083168ms","start":"2026-05-01T14:24:54.34052Z","end":"2026-05-01T14:24:54.641603Z","steps":["trace[1677186396] 'process raft request' (duration: 300.782619ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:54.641821Z","caller":"traceutil/trace.go:171","msg":"trace[1240736565] transaction","detail":"{read_only:false; response_revision:8178; number_of_response:1; }","duration":"298.622938ms","start":"2026-05-01T14:24:54.343172Z","end":"2026-05-01T14:24:54.641795Z","steps":["trace[1240736565] 'process raft request' (duration: 298.370161ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:54.641841Z","caller":"traceutil/trace.go:171","msg":"trace[1799403147] linearizableReadLoop","detail":"{readStateIndex:8463; appliedIndex:8460; }","duration":"298.7017ms","start":"2026-05-01T14:24:54.343108Z","end":"2026-05-01T14:24:54.64181Z","steps":["trace[1799403147] 'read index received' (duration: 232.907255ms)","trace[1799403147] 'applied index is now lower than readState.Index' (duration: 65.793215ms)"],"step_count":2} {"level":"warn","ts":"2026-05-01T14:24:54.641881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:24:54.340505Z","time spent":"301.240772ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:24:54.641935Z","caller":"traceutil/trace.go:171","msg":"trace[1501738636] transaction","detail":"{read_only:false; response_revision:8179; number_of_response:1; }","duration":"211.670707ms","start":"2026-05-01T14:24:54.430226Z","end":"2026-05-01T14:24:54.641897Z","steps":["trace[1501738636] 'process raft request' (duration: 211.447971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:24:54.6422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.05753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cdjtp\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-01T14:24:54.64225Z","caller":"traceutil/trace.go:171","msg":"trace[768929209] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cdjtp; range_end:; response_count:1; response_revision:8179; }","duration":"299.151913ms","start":"2026-05-01T14:24:54.343081Z","end":"2026-05-01T14:24:54.642233Z","steps":["trace[768929209] 'agreement among raft nodes before linearized reading' (duration: 298.897166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:24:54.642256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.212296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-05-01T14:24:54.642302Z","caller":"traceutil/trace.go:171","msg":"trace[1528075264] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8179; }","duration":"237.259588ms","start":"2026-05-01T14:24:54.405029Z","end":"2026-05-01T14:24:54.642289Z","steps":["trace[1528075264] 'agreement among raft nodes before linearized reading' (duration: 237.075323ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:55.430816Z","caller":"traceutil/trace.go:171","msg":"trace[210629366] transaction","detail":"{read_only:false; response_revision:8182; number_of_response:1; }","duration":"254.846833ms","start":"2026-05-01T14:24:55.175938Z","end":"2026-05-01T14:24:55.430785Z","steps":["trace[210629366] 'process raft request' (duration: 182.338469ms)","trace[210629366] 'compare' (duration: 72.287098ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:24:55.431044Z","caller":"traceutil/trace.go:171","msg":"trace[590792260] transaction","detail":"{read_only:false; response_revision:8183; number_of_response:1; }","duration":"236.524657ms","start":"2026-05-01T14:24:55.194463Z","end":"2026-05-01T14:24:55.430988Z","steps":["trace[590792260] 'process raft request' (duration: 236.27789ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:24:55.876Z","caller":"traceutil/trace.go:171","msg":"trace[1081082958] transaction","detail":"{read_only:false; response_revision:8186; number_of_response:1; }","duration":"161.07647ms","start":"2026-05-01T14:24:55.714883Z","end":"2026-05-01T14:24:55.875959Z","steps":["trace[1081082958] 'process raft request' (duration: 109.364643ms)","trace[1081082958] 'compare' (duration: 51.048898ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:25:10.655313Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6100} {"level":"info","ts":"2026-05-01T14:25:10.754524Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6100,"took":"97.012664ms","hash":116529553,"current-db-size-bytes":57544704,"current-db-size":"58 MB","current-db-size-in-use-bytes":23027712,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-05-01T14:25:10.7546Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":116529553,"revision":6100,"compact-revision":2987} {"level":"info","ts":"2026-05-01T14:25:36.358726Z","caller":"traceutil/trace.go:171","msg":"trace[1656701562] transaction","detail":"{read_only:false; response_revision:8497; number_of_response:1; }","duration":"134.285425ms","start":"2026-05-01T14:25:36.224398Z","end":"2026-05-01T14:25:36.358684Z","steps":["trace[1656701562] 'process raft request' (duration: 133.846943ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:25:36.587821Z","caller":"traceutil/trace.go:171","msg":"trace[1786600114] transaction","detail":"{read_only:false; response_revision:8498; number_of_response:1; }","duration":"207.149659ms","start":"2026-05-01T14:25:36.38063Z","end":"2026-05-01T14:25:36.587779Z","steps":["trace[1786600114] 'process raft request' (duration: 165.840964ms)","trace[1786600114] 'compare' (duration: 41.053518ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:25:36.62315Z","caller":"traceutil/trace.go:171","msg":"trace[703951415] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"112.512802ms","start":"2026-05-01T14:25:36.51062Z","end":"2026-05-01T14:25:36.623133Z","steps":["trace[703951415] 'process raft request' (duration: 112.417969ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:25:37.290028Z","caller":"traceutil/trace.go:171","msg":"trace[1125905152] transaction","detail":"{read_only:false; response_revision:8507; number_of_response:1; }","duration":"121.208818ms","start":"2026-05-01T14:25:37.168788Z","end":"2026-05-01T14:25:37.289997Z","steps":["trace[1125905152] 'process raft request' (duration: 121.017552ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:25:37.302986Z","caller":"traceutil/trace.go:171","msg":"trace[2076913337] transaction","detail":"{read_only:false; response_revision:8508; number_of_response:1; }","duration":"102.322974ms","start":"2026-05-01T14:25:37.200647Z","end":"2026-05-01T14:25:37.30297Z","steps":["trace[2076913337] 'process raft request' (duration: 102.088837ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:26:24.204154Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000242e.wal"} {"level":"info","ts":"2026-05-01T14:26:47.479908Z","caller":"traceutil/trace.go:171","msg":"trace[1045629164] transaction","detail":"{read_only:false; response_revision:9219; number_of_response:1; }","duration":"138.654478ms","start":"2026-05-01T14:26:47.341228Z","end":"2026-05-01T14:26:47.479882Z","steps":["trace[1045629164] 'process raft request' (duration: 138.472993ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:26:47.480239Z","caller":"traceutil/trace.go:171","msg":"trace[1831645395] transaction","detail":"{read_only:false; response_revision:9220; number_of_response:1; }","duration":"138.755121ms","start":"2026-05-01T14:26:47.341444Z","end":"2026-05-01T14:26:47.480199Z","steps":["trace[1831645395] 'process raft request' (duration: 138.36943ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:26:47.480349Z","caller":"traceutil/trace.go:171","msg":"trace[1341062784] transaction","detail":"{read_only:false; response_revision:9222; number_of_response:1; }","duration":"113.068217ms","start":"2026-05-01T14:26:47.367258Z","end":"2026-05-01T14:26:47.480326Z","steps":["trace[1341062784] 'process raft request' (duration: 112.987035ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:26:47.480403Z","caller":"traceutil/trace.go:171","msg":"trace[1743641928] transaction","detail":"{read_only:false; response_revision:9221; number_of_response:1; }","duration":"138.667218ms","start":"2026-05-01T14:26:47.34169Z","end":"2026-05-01T14:26:47.480357Z","steps":["trace[1743641928] 'process raft request' (duration: 138.36209ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:27:50.046217Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"1c917701ce165bac","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-05-01T14:27:50.052002Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-05-01T14:27:50.052122Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-05-01T14:30:02.800975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605828355489220801,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-01T14:30:02.97423Z","caller":"traceutil/trace.go:171","msg":"trace[689165760] transaction","detail":"{read_only:false; response_revision:10883; number_of_response:1; }","duration":"798.60326ms","start":"2026-05-01T14:30:02.175601Z","end":"2026-05-01T14:30:02.974204Z","steps":["trace[689165760] 'process raft request' (duration: 798.425385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.974391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.17558Z","time spent":"798.727183ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:30:02.977427Z","caller":"traceutil/trace.go:171","msg":"trace[839422465] transaction","detail":"{read_only:false; response_revision:10884; number_of_response:1; }","duration":"713.580029ms","start":"2026-05-01T14:30:02.263829Z","end":"2026-05-01T14:30:02.977409Z","steps":["trace[839422465] 'process raft request' (duration: 713.364953ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.977524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.263804Z","time spent":"713.670172ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:30:02.977574Z","caller":"traceutil/trace.go:171","msg":"trace[75735897] transaction","detail":"{read_only:false; response_revision:10887; number_of_response:1; }","duration":"419.859078ms","start":"2026-05-01T14:30:02.557695Z","end":"2026-05-01T14:30:02.977554Z","steps":["trace[75735897] 'process raft request' (duration: 419.751325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.97763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"676.719801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-01T14:30:02.977672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.557669Z","time spent":"419.955851ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-01T14:30:02.977675Z","caller":"traceutil/trace.go:171","msg":"trace[1611377059] transaction","detail":"{read_only:false; response_revision:10886; number_of_response:1; }","duration":"480.078291ms","start":"2026-05-01T14:30:02.49744Z","end":"2026-05-01T14:30:02.977518Z","steps":["trace[1611377059] 'process raft request' (duration: 479.935847ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:30:02.977511Z","caller":"traceutil/trace.go:171","msg":"trace[1628602309] linearizableReadLoop","detail":"{readStateIndex:11257; appliedIndex:11252; }","duration":"676.594148ms","start":"2026-05-01T14:30:02.300889Z","end":"2026-05-01T14:30:02.977483Z","steps":["trace[1628602309] 'read index received' (duration: 673.284755ms)","trace[1628602309] 'applied index is now lower than readState.Index' (duration: 3.308303ms)"],"step_count":2} {"level":"info","ts":"2026-05-01T14:30:02.977791Z","caller":"traceutil/trace.go:171","msg":"trace[1840727934] transaction","detail":"{read_only:false; response_revision:10885; number_of_response:1; }","duration":"707.873388ms","start":"2026-05-01T14:30:02.269757Z","end":"2026-05-01T14:30:02.97763Z","steps":["trace[1840727934] 'process raft request' (duration: 707.57379ms)"],"step_count":1} {"level":"info","ts":"2026-05-01T14:30:02.977862Z","caller":"traceutil/trace.go:171","msg":"trace[1640591265] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:10887; }","duration":"676.834234ms","start":"2026-05-01T14:30:02.300838Z","end":"2026-05-01T14:30:02.977672Z","steps":["trace[1640591265] 'agreement among raft nodes before linearized reading' (duration: 676.725421ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.978351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.300819Z","time spent":"677.517975ms","remote":"127.0.0.1:53556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "} {"level":"warn","ts":"2026-05-01T14:30:02.977875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.497413Z","time spent":"480.38697ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:30:02.977916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.269744Z","time spent":"708.115625ms","remote":"127.0.0.1:35388","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5594,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-01T14:30:02.977957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.343731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-01T14:30:02.978777Z","caller":"traceutil/trace.go:171","msg":"trace[1270876505] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:10887; }","duration":"203.186253ms","start":"2026-05-01T14:30:02.775576Z","end":"2026-05-01T14:30:02.978763Z","steps":["trace[1270876505] 'agreement among raft nodes before linearized reading' (duration: 202.33426ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.978017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.917032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-05-01T14:30:02.97908Z","caller":"traceutil/trace.go:171","msg":"trace[332738736] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:10887; }","duration":"205.989274ms","start":"2026-05-01T14:30:02.773073Z","end":"2026-05-01T14:30:02.979062Z","steps":["trace[332738736] 'agreement among raft nodes before linearized reading' (duration: 204.851361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.978044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.842947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-cdjtp\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-05-01T14:30:02.979172Z","caller":"traceutil/trace.go:171","msg":"trace[104947787] range","detail":"{range_begin:/registry/pods/openstack/keepalived-cdjtp; range_end:; response_count:1; response_revision:10887; }","duration":"331.01415ms","start":"2026-05-01T14:30:02.648142Z","end":"2026-05-01T14:30:02.979156Z","steps":["trace[104947787] 'agreement among raft nodes before linearized reading' (duration: 329.783855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.978045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.632427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-01T14:30:02.979227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.648115Z","time spent":"331.096413ms","remote":"127.0.0.1:35346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6547,"request content":"key:\"/registry/pods/openstack/keepalived-cdjtp\" "} {"level":"info","ts":"2026-05-01T14:30:02.979267Z","caller":"traceutil/trace.go:171","msg":"trace[1986955530] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:10887; }","duration":"145.880923ms","start":"2026-05-01T14:30:02.83337Z","end":"2026-05-01T14:30:02.979251Z","steps":["trace[1986955530] 'agreement among raft nodes before linearized reading' (duration: 144.615787ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.978085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.074477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-01T14:30:02.979359Z","caller":"traceutil/trace.go:171","msg":"trace[1266549163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:10887; }","duration":"195.348104ms","start":"2026-05-01T14:30:02.783984Z","end":"2026-05-01T14:30:02.979332Z","steps":["trace[1266549163] 'agreement among raft nodes before linearized reading' (duration: 194.078278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.97805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.480523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-01T14:30:02.979518Z","caller":"traceutil/trace.go:171","msg":"trace[1431705606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:10887; }","duration":"657.955554ms","start":"2026-05-01T14:30:02.321521Z","end":"2026-05-01T14:30:02.979477Z","steps":["trace[1431705606] 'agreement among raft nodes before linearized reading' (duration: 656.344548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.979586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.321514Z","time spent":"658.053687ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-01T14:30:02.978088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.10017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/cinder-backup-795959c9c4-rjtx6.18ab776eaebcc126\" ","response":"range_response_count:1 size:804"} {"level":"info","ts":"2026-05-01T14:30:02.97965Z","caller":"traceutil/trace.go:171","msg":"trace[1341398754] range","detail":"{range_begin:/registry/events/openstack/cinder-backup-795959c9c4-rjtx6.18ab776eaebcc126; range_end:; response_count:1; response_revision:10887; }","duration":"226.704366ms","start":"2026-05-01T14:30:02.752931Z","end":"2026-05-01T14:30:02.979635Z","steps":["trace[1341398754] 'agreement among raft nodes before linearized reading' (duration: 225.030898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.978134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.38232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-01T14:30:02.979729Z","caller":"traceutil/trace.go:171","msg":"trace[1050222520] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:10887; }","duration":"524.961274ms","start":"2026-05-01T14:30:02.454737Z","end":"2026-05-01T14:30:02.979698Z","steps":["trace[1050222520] 'agreement among raft nodes before linearized reading' (duration: 523.340118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.978183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.197991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-05-01T14:30:02.97983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.454732Z","time spent":"525.067067ms","remote":"127.0.0.1:35402","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-05-01T14:30:02.979849Z","caller":"traceutil/trace.go:171","msg":"trace[928769057] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:10887; }","duration":"531.873278ms","start":"2026-05-01T14:30:02.447961Z","end":"2026-05-01T14:30:02.979835Z","steps":["trace[928769057] 'agreement among raft nodes before linearized reading' (duration: 530.133729ms)"],"step_count":1} {"level":"warn","ts":"2026-05-01T14:30:02.979906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-01T14:30:02.447955Z","time spent":"531.93418ms","remote":"127.0.0.1:35402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-01T14:30:10.661322Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8268} {"level":"info","ts":"2026-05-01T14:30:10.733757Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8268,"took":"70.270987ms","hash":2693822743,"current-db-size-bytes":57544704,"current-db-size":"58 MB","current-db-size-in-use-bytes":26546176,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-05-01T14:30:10.733837Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2693822743,"revision":8268,"compact-revision":6100} {"level":"info","ts":"2026-05-01T14:35:10.667969Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10947} {"level":"info","ts":"2026-05-01T14:35:10.745678Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10947,"took":"75.223563ms","hash":542324912,"current-db-size-bytes":57544704,"current-db-size":"58 MB","current-db-size-in-use-bytes":27627520,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-05-01T14:35:10.745729Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":542324912,"revision":10947,"compact-revision":8268} {"level":"info","ts":"2026-05-01T14:40:10.676734Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12989} {"level":"info","ts":"2026-05-01T14:40:10.751971Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12989,"took":"71.901123ms","hash":3446616353,"current-db-size-bytes":57544704,"current-db-size":"58 MB","current-db-size-in-use-bytes":23527424,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-05-01T14:40:10.752032Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3446616353,"revision":12989,"compact-revision":10947}