{"level":"warn","ts":"2026-04-20T05:52:37.617197Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T05:52:37.617312Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.192:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.192:2380","--initial-cluster=instance=https://199.19.213.192:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.192:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.192:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T05:52:37.617403Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T05:52:37.61741Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.192:2380"]} {"level":"info","ts":"2026-04-20T05:52:37.617431Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T05:52:37.618118Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"]} {"level":"info","ts":"2026-04-20T05:52:37.618193Z","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.19.213.192:2380"],"listen-peer-urls":["https://199.19.213.192:2380"],"advertise-client-urls":["https://199.19.213.192:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.192:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T05:52:37.62325Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.799495ms"} {"level":"info","ts":"2026-04-20T05:52:37.632603Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"341a3703c39c1f5b","cluster-id":"65341987fa712ba2"} {"level":"info","ts":"2026-04-20T05:52:37.632732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T05:52:37.632777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became follower at term 0"} {"level":"info","ts":"2026-04-20T05:52:37.632795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 341a3703c39c1f5b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T05:52:37.63282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became follower at term 1"} {"level":"info","ts":"2026-04-20T05:52:37.632886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=(3754373728672948059)"} {"level":"warn","ts":"2026-04-20T05:52:37.638334Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T05:52:37.639906Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T05:52:37.641037Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T05:52:37.643118Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"341a3703c39c1f5b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T05:52:37.643292Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"341a3703c39c1f5b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T05:52:37.643348Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T05:52:37.643542Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T05:52:37.643579Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T05:52:37.645956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b switched to configuration voters=(3754373728672948059)"} {"level":"info","ts":"2026-04-20T05:52:37.646162Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"65341987fa712ba2","local-member-id":"341a3703c39c1f5b","added-peer-id":"341a3703c39c1f5b","added-peer-peer-urls":["https://199.19.213.192:2380"]} {"level":"info","ts":"2026-04-20T05:52:37.647759Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T05:52:37.647939Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.192:2380"} {"level":"info","ts":"2026-04-20T05:52:37.64802Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.192:2380"} {"level":"info","ts":"2026-04-20T05:52:37.648067Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"341a3703c39c1f5b","initial-advertise-peer-urls":["https://199.19.213.192:2380"],"listen-peer-urls":["https://199.19.213.192:2380"],"advertise-client-urls":["https://199.19.213.192:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.192:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T05:52:37.648105Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T05:52:38.333834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T05:52:38.333941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T05:52:38.333997Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b received MsgPreVoteResp from 341a3703c39c1f5b at term 1"} {"level":"info","ts":"2026-04-20T05:52:38.334022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became candidate at term 2"} {"level":"info","ts":"2026-04-20T05:52:38.334042Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b received MsgVoteResp from 341a3703c39c1f5b at term 2"} {"level":"info","ts":"2026-04-20T05:52:38.334062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"341a3703c39c1f5b became leader at term 2"} {"level":"info","ts":"2026-04-20T05:52:38.334077Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 341a3703c39c1f5b elected leader 341a3703c39c1f5b at term 2"} {"level":"info","ts":"2026-04-20T05:52:38.335262Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:52:38.336274Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:52:38.336279Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"341a3703c39c1f5b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.192:2379]}","request-path":"/0/members/341a3703c39c1f5b/attributes","cluster-id":"65341987fa712ba2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T05:52:38.336349Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:52:38.336776Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T05:52:38.336843Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T05:52:38.337749Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"65341987fa712ba2","local-member-id":"341a3703c39c1f5b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:52:38.337886Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:52:38.337928Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:52:38.340018Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T05:52:38.340026Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.192:2379"} {"level":"info","ts":"2026-04-20T05:52:55.148531Z","caller":"traceutil/trace.go:171","msg":"trace[1495256535] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"113.98531ms","start":"2026-04-20T05:52:55.034506Z","end":"2026-04-20T05:52:55.148491Z","steps":["trace[1495256535] 'process raft request' (duration: 113.679521ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:53:15.605497Z","caller":"traceutil/trace.go:171","msg":"trace[1845046824] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"101.911874ms","start":"2026-04-20T05:53:15.503544Z","end":"2026-04-20T05:53:15.605456Z","steps":["trace[1845046824] 'process raft request' (duration: 101.678538ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:53:15.750915Z","caller":"traceutil/trace.go:171","msg":"trace[1052879424] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"240.486953ms","start":"2026-04-20T05:53:15.510385Z","end":"2026-04-20T05:53:15.750872Z","steps":["trace[1052879424] 'process raft request' (duration: 212.10166ms)","trace[1052879424] 'compare' (duration: 28.224789ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:53:15.777644Z","caller":"traceutil/trace.go:171","msg":"trace[1813121695] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"142.609985ms","start":"2026-04-20T05:53:15.634978Z","end":"2026-04-20T05:53:15.777588Z","steps":["trace[1813121695] 'process raft request' (duration: 141.863126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:16.272383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.504688ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:53:16.272558Z","caller":"traceutil/trace.go:171","msg":"trace[563046569] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"125.764048ms","start":"2026-04-20T05:53:16.146777Z","end":"2026-04-20T05:53:16.272541Z","steps":["trace[563046569] 'read index received' (duration: 37.901µs)","trace[563046569] 'applied index is now lower than readState.Index' (duration: 125.724927ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:53:16.272667Z","caller":"traceutil/trace.go:171","msg":"trace[412179550] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"431.125964ms","start":"2026-04-20T05:53:15.841469Z","end":"2026-04-20T05:53:16.272594Z","steps":["trace[412179550] 'process raft request' (duration: 25.871997ms)","trace[412179550] 'compare' (duration: 404.279621ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:53:16.272744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.970334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T05:53:16.272786Z","caller":"traceutil/trace.go:171","msg":"trace[1709056917] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:582; }","duration":"126.072926ms","start":"2026-04-20T05:53:16.146703Z","end":"2026-04-20T05:53:16.272776Z","steps":["trace[1709056917] 'agreement among raft nodes before linearized reading' (duration: 125.887412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:53:16.27291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:53:15.841417Z","time spent":"431.374521ms","remote":"127.0.0.1:52152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T05:53:17.660365Z","caller":"traceutil/trace.go:171","msg":"trace[1793301336] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"108.904361ms","start":"2026-04-20T05:53:17.551431Z","end":"2026-04-20T05:53:17.660335Z","steps":["trace[1793301336] 'process raft request' (duration: 101.718549ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:53:17.668083Z","caller":"traceutil/trace.go:171","msg":"trace[453985618] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"113.963294ms","start":"2026-04-20T05:53:17.554093Z","end":"2026-04-20T05:53:17.668057Z","steps":["trace[453985618] 'process raft request' (duration: 113.656796ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:53:57.677697Z","caller":"traceutil/trace.go:171","msg":"trace[1652231979] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"132.073846ms","start":"2026-04-20T05:53:57.54559Z","end":"2026-04-20T05:53:57.677664Z","steps":["trace[1652231979] 'process raft request' (duration: 131.87042ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:46.231233Z","caller":"traceutil/trace.go:171","msg":"trace[1042675410] transaction","detail":"{read_only:false; response_revision:1810; number_of_response:1; }","duration":"294.049946ms","start":"2026-04-20T05:54:45.937148Z","end":"2026-04-20T05:54:46.231198Z","steps":["trace[1042675410] 'process raft request' (duration: 293.833871ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:46.258317Z","caller":"traceutil/trace.go:171","msg":"trace[401378190] linearizableReadLoop","detail":"{readStateIndex:1879; appliedIndex:1877; }","duration":"200.223487ms","start":"2026-04-20T05:54:46.058051Z","end":"2026-04-20T05:54:46.258274Z","steps":["trace[401378190] 'read index received' (duration: 172.891698ms)","trace[401378190] 'applied index is now lower than readState.Index' (duration: 27.330129ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:54:46.258434Z","caller":"traceutil/trace.go:171","msg":"trace[406892488] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"110.53371ms","start":"2026-04-20T05:54:46.147849Z","end":"2026-04-20T05:54:46.258383Z","steps":["trace[406892488] 'process raft request' (duration: 110.359426ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:46.258473Z","caller":"traceutil/trace.go:171","msg":"trace[440624439] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"318.858839ms","start":"2026-04-20T05:54:45.939576Z","end":"2026-04-20T05:54:46.258435Z","steps":["trace[440624439] 'process raft request' (duration: 318.442197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:46.258702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.569047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-20T05:54:46.258712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.186849ms","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-04-20T05:54:46.258789Z","caller":"traceutil/trace.go:171","msg":"trace[1453484311] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1812; }","duration":"200.790404ms","start":"2026-04-20T05:54:46.057983Z","end":"2026-04-20T05:54:46.258774Z","steps":["trace[1453484311] 'agreement among raft nodes before linearized reading' (duration: 200.480065ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:46.258811Z","caller":"traceutil/trace.go:171","msg":"trace[1195916526] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1812; }","duration":"138.300732ms","start":"2026-04-20T05:54:46.120487Z","end":"2026-04-20T05:54:46.258787Z","steps":["trace[1195916526] 'agreement among raft nodes before linearized reading' (duration: 138.042175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:46.25897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:54:45.939564Z","time spent":"319.048583ms","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:54:46.646253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.219928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-20T05:54:46.64635Z","caller":"traceutil/trace.go:171","msg":"trace[1999397246] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1816; }","duration":"220.358973ms","start":"2026-04-20T05:54:46.425966Z","end":"2026-04-20T05:54:46.646325Z","steps":["trace[1999397246] 'range keys from in-memory index tree' (duration: 220.053663ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:46.738562Z","caller":"traceutil/trace.go:171","msg":"trace[1224018545] transaction","detail":"{read_only:false; response_revision:1817; number_of_response:1; }","duration":"270.322534ms","start":"2026-04-20T05:54:46.468211Z","end":"2026-04-20T05:54:46.738534Z","steps":["trace[1224018545] 'process raft request' (duration: 270.091538ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:46.743827Z","caller":"traceutil/trace.go:171","msg":"trace[1030958986] linearizableReadLoop","detail":"{readStateIndex:1886; appliedIndex:1884; }","duration":"126.277557ms","start":"2026-04-20T05:54:46.617512Z","end":"2026-04-20T05:54:46.74379Z","steps":["trace[1030958986] 'read index received' (duration: 120.882161ms)","trace[1030958986] 'applied index is now lower than readState.Index' (duration: 5.393626ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:54:46.743905Z","caller":"traceutil/trace.go:171","msg":"trace[643755744] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"160.845092ms","start":"2026-04-20T05:54:46.582983Z","end":"2026-04-20T05:54:46.743828Z","steps":["trace[643755744] 'process raft request' (duration: 159.840735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:46.744148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.595085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-199b3855-09ed-455b-a540-bd782e1dbfba\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-20T05:54:46.74424Z","caller":"traceutil/trace.go:171","msg":"trace[150778139] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-199b3855-09ed-455b-a540-bd782e1dbfba; range_end:; response_count:1; response_revision:1818; }","duration":"126.74306ms","start":"2026-04-20T05:54:46.617475Z","end":"2026-04-20T05:54:46.744218Z","steps":["trace[150778139] 'agreement among raft nodes before linearized reading' (duration: 126.443722ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:55:41.177382Z","caller":"traceutil/trace.go:171","msg":"trace[1374732241] transaction","detail":"{read_only:false; response_revision:2160; number_of_response:1; }","duration":"146.933219ms","start":"2026-04-20T05:55:41.030418Z","end":"2026-04-20T05:55:41.177351Z","steps":["trace[1374732241] 'process raft request' (duration: 146.630141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:55:41.41618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.442721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:55:41.416348Z","caller":"traceutil/trace.go:171","msg":"trace[1761134851] linearizableReadLoop","detail":"{readStateIndex:2241; appliedIndex:2240; }","duration":"135.019666ms","start":"2026-04-20T05:55:41.281303Z","end":"2026-04-20T05:55:41.416323Z","steps":["trace[1761134851] 'read index received' (duration: 1.223054ms)","trace[1761134851] 'applied index is now lower than readState.Index' (duration: 133.794931ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:55:41.416486Z","caller":"traceutil/trace.go:171","msg":"trace[137165984] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"232.404062ms","start":"2026-04-20T05:55:41.184008Z","end":"2026-04-20T05:55:41.416412Z","steps":["trace[137165984] 'process raft request' (duration: 98.58178ms)","trace[137165984] 'compare' (duration: 133.280536ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:55:41.416548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.20073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T05:55:41.416655Z","caller":"traceutil/trace.go:171","msg":"trace[2104727020] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:2161; }","duration":"135.331274ms","start":"2026-04-20T05:55:41.281297Z","end":"2026-04-20T05:55:41.416629Z","steps":["trace[2104727020] 'agreement among raft nodes before linearized reading' (duration: 135.122058ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:55:41.479959Z","caller":"traceutil/trace.go:171","msg":"trace[1689508081] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"164.070807ms","start":"2026-04-20T05:55:41.315868Z","end":"2026-04-20T05:55:41.479938Z","steps":["trace[1689508081] 'process raft request' (duration: 163.917273ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:55:41.687711Z","caller":"traceutil/trace.go:171","msg":"trace[1733644739] linearizableReadLoop","detail":"{readStateIndex:2243; appliedIndex:2241; }","duration":"271.309903ms","start":"2026-04-20T05:55:41.416379Z","end":"2026-04-20T05:55:41.687689Z","steps":["trace[1733644739] 'read index received' (duration: 63.523313ms)","trace[1733644739] 'applied index is now lower than readState.Index' (duration: 207.78517ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:55:41.687853Z","caller":"traceutil/trace.go:171","msg":"trace[569182175] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"370.618603ms","start":"2026-04-20T05:55:41.317187Z","end":"2026-04-20T05:55:41.687805Z","steps":["trace[569182175] 'process raft request' (duration: 370.361276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:55:41.688121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.321189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.192\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T05:55:41.688162Z","caller":"traceutil/trace.go:171","msg":"trace[1318513286] range","detail":"{range_begin:/registry/masterleases/199.19.213.192; range_end:; response_count:1; response_revision:2163; }","duration":"236.374951ms","start":"2026-04-20T05:55:41.451774Z","end":"2026-04-20T05:55:41.688149Z","steps":["trace[1318513286] 'agreement among raft nodes before linearized reading' (duration: 236.229337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:55:41.687965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.168531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:55:41.688258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:55:41.317172Z","time spent":"370.850491ms","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:55:41.688263Z","caller":"traceutil/trace.go:171","msg":"trace[66166645] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/; range_end:/registry/rabbitmq.com/rabbitmqclusters0; response_count:0; response_revision:2163; }","duration":"322.517212ms","start":"2026-04-20T05:55:41.365698Z","end":"2026-04-20T05:55:41.688215Z","steps":["trace[66166645] 'agreement among raft nodes before linearized reading' (duration: 322.195922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:55:41.688727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:55:41.36566Z","time spent":"323.041106ms","remote":"127.0.0.1:33544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/\" range_end:\"/registry/rabbitmq.com/rabbitmqclusters0\" count_only:true "} {"level":"info","ts":"2026-04-20T06:00:48.033687Z","caller":"traceutil/trace.go:171","msg":"trace[817025634] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"106.343632ms","start":"2026-04-20T06:00:47.927304Z","end":"2026-04-20T06:00:48.033647Z","steps":["trace[817025634] 'process raft request' (duration: 31.845908ms)","trace[817025634] 'compare' (duration: 74.311128ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:00:56.689402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.849069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:00:56.689544Z","caller":"traceutil/trace.go:171","msg":"trace[2043138848] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:4966; }","duration":"134.037814ms","start":"2026-04-20T06:00:56.555481Z","end":"2026-04-20T06:00:56.689519Z","steps":["trace[2043138848] 'count revisions from in-memory index tree' (duration: 133.708485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:01:08.967768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.641564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T06:01:08.968302Z","caller":"traceutil/trace.go:171","msg":"trace[617272369] linearizableReadLoop","detail":"{readStateIndex:5390; appliedIndex:5388; }","duration":"279.70382ms","start":"2026-04-20T06:01:08.688573Z","end":"2026-04-20T06:01:08.968276Z","steps":["trace[617272369] 'read index received' (duration: 67.358507ms)","trace[617272369] 'applied index is now lower than readState.Index' (duration: 212.344043ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:01:08.968358Z","caller":"traceutil/trace.go:171","msg":"trace[23023411] transaction","detail":"{read_only:false; response_revision:5193; number_of_response:1; }","duration":"280.39995ms","start":"2026-04-20T06:01:08.687947Z","end":"2026-04-20T06:01:08.968347Z","steps":["trace[23023411] 'process raft request' (duration: 68.051627ms)","trace[23023411] 'compare' (duration: 211.382106ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:01:08.968275Z","caller":"traceutil/trace.go:171","msg":"trace[96411496] transaction","detail":"{read_only:false; response_revision:5194; number_of_response:1; }","duration":"280.190413ms","start":"2026-04-20T06:01:08.688049Z","end":"2026-04-20T06:01:08.968239Z","steps":["trace[96411496] 'process raft request' (duration: 279.837424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:01:08.968567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.974408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16454"} {"level":"info","ts":"2026-04-20T06:01:08.968646Z","caller":"traceutil/trace.go:171","msg":"trace[1054606467] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5196; }","duration":"280.06843ms","start":"2026-04-20T06:01:08.688558Z","end":"2026-04-20T06:01:08.968626Z","steps":["trace[1054606467] 'agreement among raft nodes before linearized reading' (duration: 279.852044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:01:08.968758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.340866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:01:08.968806Z","caller":"traceutil/trace.go:171","msg":"trace[445052372] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5196; }","duration":"236.441689ms","start":"2026-04-20T06:01:08.732353Z","end":"2026-04-20T06:01:08.968795Z","steps":["trace[445052372] 'agreement among raft nodes before linearized reading' (duration: 236.355746ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:01:08.968858Z","caller":"traceutil/trace.go:171","msg":"trace[1789458810] transaction","detail":"{read_only:false; response_revision:5195; number_of_response:1; }","duration":"208.693393ms","start":"2026-04-20T06:01:08.760152Z","end":"2026-04-20T06:01:08.968845Z","steps":["trace[1789458810] 'process raft request' (duration: 207.807478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:01:09.195643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.477276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-04-20T06:01:09.195727Z","caller":"traceutil/trace.go:171","msg":"trace[433424664] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5196; }","duration":"118.725693ms","start":"2026-04-20T06:01:09.076983Z","end":"2026-04-20T06:01:09.195708Z","steps":["trace[433424664] 'range keys from in-memory index tree' (duration: 118.315802ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:01:16.620685Z","caller":"traceutil/trace.go:171","msg":"trace[1864635974] linearizableReadLoop","detail":"{readStateIndex:5529; appliedIndex:5528; }","duration":"100.926782ms","start":"2026-04-20T06:01:16.519725Z","end":"2026-04-20T06:01:16.620652Z","steps":["trace[1864635974] 'read index received' (duration: 87.711977ms)","trace[1864635974] 'applied index is now lower than readState.Index' (duration: 13.213455ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:01:16.620969Z","caller":"traceutil/trace.go:171","msg":"trace[1511755455] transaction","detail":"{read_only:false; response_revision:5332; number_of_response:1; }","duration":"113.989611ms","start":"2026-04-20T06:01:16.506964Z","end":"2026-04-20T06:01:16.620953Z","steps":["trace[1511755455] 'process raft request' (duration: 100.554001ms)","trace[1511755455] 'compare' (duration: 13.000298ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:01:16.621278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.545828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T06:01:16.621325Z","caller":"traceutil/trace.go:171","msg":"trace[226396694] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5332; }","duration":"101.655032ms","start":"2026-04-20T06:01:16.51966Z","end":"2026-04-20T06:01:16.621315Z","steps":["trace[226396694] 'agreement among raft nodes before linearized reading' (duration: 101.484507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:01:16.621525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.715216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T06:01:16.621553Z","caller":"traceutil/trace.go:171","msg":"trace[2095978568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5332; }","duration":"100.764186ms","start":"2026-04-20T06:01:16.52078Z","end":"2026-04-20T06:01:16.621544Z","steps":["trace[2095978568] 'agreement among raft nodes before linearized reading' (duration: 100.677754ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:01:16.622126Z","caller":"traceutil/trace.go:171","msg":"trace[1069677255] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5332; }","duration":"100.001737ms","start":"2026-04-20T06:01:16.522113Z","end":"2026-04-20T06:01:16.622115Z","steps":["trace[1069677255] 'agreement among raft nodes before linearized reading' (duration: 99.954756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:01:16.940598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.575288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T06:01:16.940726Z","caller":"traceutil/trace.go:171","msg":"trace[487960357] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:5336; }","duration":"192.780373ms","start":"2026-04-20T06:01:16.747918Z","end":"2026-04-20T06:01:16.940698Z","steps":["trace[487960357] 'count revisions from in-memory index tree' (duration: 192.428143ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:01:17.149585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.29889ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-20T06:01:17.150043Z","caller":"traceutil/trace.go:171","msg":"trace[2098823579] transaction","detail":"{read_only:false; response_revision:5337; number_of_response:1; }","duration":"142.748155ms","start":"2026-04-20T06:01:17.00726Z","end":"2026-04-20T06:01:17.150008Z","steps":["trace[2098823579] 'process raft request' (duration: 142.450827ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:01:17.17546Z","caller":"traceutil/trace.go:171","msg":"trace[229319653] transaction","detail":"{read_only:false; response_revision:5338; number_of_response:1; }","duration":"156.279178ms","start":"2026-04-20T06:01:17.019144Z","end":"2026-04-20T06:01:17.175423Z","steps":["trace[229319653] 'process raft request' (duration: 150.329004ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:02:38.365149Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2995} {"level":"info","ts":"2026-04-20T06:02:38.444707Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2995,"took":"77.367409ms","hash":2772004545,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":34066432,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-20T06:02:38.444808Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2772004545,"revision":2995,"compact-revision":-1} {"level":"warn","ts":"2026-04-20T06:06:38.781021Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2259572989155297497,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:39.281914Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2259572989155297497,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:39.78209Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2259572989155297497,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:40.280601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999928721s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-20T06:06:40.280726Z","caller":"traceutil/trace.go:171","msg":"trace[378087206] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000155488s","start":"2026-04-20T06:06:38.280535Z","end":"2026-04-20T06:06:40.280691Z","steps":["trace[378087206] 'agreement among raft nodes before linearized reading' (duration: 1.999983643s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.28078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.280505Z","time spent":"2.000265871s","remote":"127.0.0.1:51656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/20 06:06:40 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-20T06:06:40.282885Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2259572989155297497,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-20T06:06:40.488816Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.341636025s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T06:06:40.489317Z","caller":"traceutil/trace.go:171","msg":"trace[137311152] transaction","detail":"{read_only:false; response_revision:7765; number_of_response:1; }","duration":"2.342280053s","start":"2026-04-20T06:06:38.147Z","end":"2026-04-20T06:06:40.48928Z","steps":["trace[137311152] 'process raft request' (duration: 2.342051157s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.489553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.146969Z","time spent":"2.342467628s","remote":"127.0.0.1:51902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12802,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:06:40.494239Z","caller":"traceutil/trace.go:171","msg":"trace[497405038] transaction","detail":"{read_only:false; response_revision:7766; number_of_response:1; }","duration":"2.34691226s","start":"2026-04-20T06:06:38.147266Z","end":"2026-04-20T06:06:40.494179Z","steps":["trace[497405038] 'process raft request' (duration: 2.345934203s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.494551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.147223Z","time spent":"2.347133676s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:06:40.494994Z","caller":"traceutil/trace.go:171","msg":"trace[1092329363] transaction","detail":"{read_only:false; response_revision:7767; number_of_response:1; }","duration":"2.21793967s","start":"2026-04-20T06:06:38.277018Z","end":"2026-04-20T06:06:40.494957Z","steps":["trace[1092329363] 'process raft request' (duration: 2.21646463s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.276991Z","time spent":"2.218075273s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:06:40.495156Z","caller":"traceutil/trace.go:171","msg":"trace[383624508] transaction","detail":"{read_only:false; response_revision:7770; number_of_response:1; }","duration":"1.300590698s","start":"2026-04-20T06:06:39.194541Z","end":"2026-04-20T06:06:40.495131Z","steps":["trace[383624508] 'process raft request' (duration: 1.300364132s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:40.495188Z","caller":"traceutil/trace.go:171","msg":"trace[960182116] transaction","detail":"{read_only:false; response_revision:7772; number_of_response:1; }","duration":"460.320891ms","start":"2026-04-20T06:06:40.034856Z","end":"2026-04-20T06:06:40.495177Z","steps":["trace[960182116] 'process raft request' (duration: 460.123125ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:40.495074Z","caller":"traceutil/trace.go:171","msg":"trace[464811855] linearizableReadLoop","detail":"{readStateIndex:8048; appliedIndex:8040; }","duration":"2.214403554s","start":"2026-04-20T06:06:38.280621Z","end":"2026-04-20T06:06:40.495025Z","steps":["trace[464811855] 'read index received' (duration: 2.20841291s)","trace[464811855] 'applied index is now lower than readState.Index' (duration: 5.989444ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:06:40.495246Z","caller":"traceutil/trace.go:171","msg":"trace[1372209191] transaction","detail":"{read_only:false; response_revision:7768; number_of_response:1; }","duration":"2.033064955s","start":"2026-04-20T06:06:38.462156Z","end":"2026-04-20T06:06:40.49522Z","steps":["trace[1372209191] 'process raft request' (duration: 2.031490162s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:40.495242Z","caller":"traceutil/trace.go:171","msg":"trace[1959566399] transaction","detail":"{read_only:false; response_revision:7771; number_of_response:1; }","duration":"1.234930887s","start":"2026-04-20T06:06:39.260255Z","end":"2026-04-20T06:06:40.495186Z","steps":["trace[1959566399] 'process raft request' (duration: 1.234694971s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:40.034826Z","time spent":"460.389073ms","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:06:40.495301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.194511Z","time spent":"1.300705012s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:06:40.495383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.462133Z","time spent":"2.033164678s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:06:40.49539Z","caller":"traceutil/trace.go:171","msg":"trace[1988929455] transaction","detail":"{read_only:false; response_revision:7769; number_of_response:1; }","duration":"2.028928793s","start":"2026-04-20T06:06:38.4664Z","end":"2026-04-20T06:06:40.495329Z","steps":["trace[1988929455] 'process raft request' (duration: 2.02734182s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.26024Z","time spent":"1.235090431s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:06:40.495493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.392601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-20T06:06:40.495497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.103862128s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T06:06:40.495524Z","caller":"traceutil/trace.go:171","msg":"trace[1251156826] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:7772; }","duration":"715.446753ms","start":"2026-04-20T06:06:39.780068Z","end":"2026-04-20T06:06:40.495515Z","steps":["trace[1251156826] 'agreement among raft nodes before linearized reading' (duration: 715.38516ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:40.495532Z","caller":"traceutil/trace.go:171","msg":"trace[1570892208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7772; }","duration":"2.10392457s","start":"2026-04-20T06:06:38.391599Z","end":"2026-04-20T06:06:40.495523Z","steps":["trace[1570892208] 'agreement among raft nodes before linearized reading' (duration: 2.103781205s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.79354315s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-52h7f\" ","response":"range_response_count:1 size:6530"} {"level":"warn","ts":"2026-04-20T06:06:40.495555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.391586Z","time spent":"2.103964122s","remote":"127.0.0.1:51930","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-04-20T06:06:40.495579Z","caller":"traceutil/trace.go:171","msg":"trace[1877697154] range","detail":"{range_begin:/registry/pods/openstack/keepalived-52h7f; range_end:; response_count:1; response_revision:7772; }","duration":"1.793601842s","start":"2026-04-20T06:06:38.701965Z","end":"2026-04-20T06:06:40.495567Z","steps":["trace[1877697154] 'agreement among raft nodes before linearized reading' (duration: 1.793447597s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.458303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:06:40.495585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.466374Z","time spent":"2.029105888s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:06:40.495602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.110299094s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-04-20T06:06:40.495616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.701954Z","time spent":"1.793652853s","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6552,"request content":"key:\"/registry/pods/openstack/keepalived-52h7f\" "} {"level":"warn","ts":"2026-04-20T06:06:40.495608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.491198641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-20T06:06:40.495603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.718536754s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:06:40.495669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.05744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T06:06:40.495694Z","caller":"traceutil/trace.go:171","msg":"trace[1269356636] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:7772; }","duration":"535.143332ms","start":"2026-04-20T06:06:39.960544Z","end":"2026-04-20T06:06:40.495688Z","steps":["trace[1269356636] 'agreement among raft nodes before linearized reading' (duration: 535.079181ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:40.495689Z","caller":"traceutil/trace.go:171","msg":"trace[1032207196] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7772; }","duration":"1.491334055s","start":"2026-04-20T06:06:39.004333Z","end":"2026-04-20T06:06:40.495668Z","steps":["trace[1032207196] 'agreement among raft nodes before linearized reading' (duration: 1.491005415s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.96052Z","time spent":"535.186994ms","remote":"127.0.0.1:52096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":22,"response size":29,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:06:40.49572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.109383178s","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-04-20T06:06:40.495717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.951743067s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:06:40.495756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.004307Z","time spent":"1.491416556s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-20T06:06:40.495716Z","caller":"traceutil/trace.go:171","msg":"trace[623880159] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:7772; }","duration":"1.718733789s","start":"2026-04-20T06:06:38.776955Z","end":"2026-04-20T06:06:40.495688Z","steps":["trace[623880159] 'agreement among raft nodes before linearized reading' (duration: 1.718542083s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:40.495774Z","caller":"traceutil/trace.go:171","msg":"trace[1486904980] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7772; }","duration":"2.109447521s","start":"2026-04-20T06:06:38.386317Z","end":"2026-04-20T06:06:40.495764Z","steps":["trace[1486904980] 'agreement among raft nodes before linearized reading' (duration: 2.109344128s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.780058Z","time spent":"715.484205ms","remote":"127.0.0.1:52094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:06:40.495815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.386308Z","time spent":"2.109498142s","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-20T06:06:40.495817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.776919Z","time spent":"1.718886334s","remote":"127.0.0.1:58468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-20T06:06:40.49561Z","caller":"traceutil/trace.go:171","msg":"trace[1684447828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7772; }","duration":"214.599876ms","start":"2026-04-20T06:06:40.281005Z","end":"2026-04-20T06:06:40.495605Z","steps":["trace[1684447828] 'agreement among raft nodes before linearized reading' (duration: 214.565685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"766.057984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:06:40.49587Z","caller":"traceutil/trace.go:171","msg":"trace[2116631150] range","detail":"{range_begin:/registry/jobs/openstack/barbican-ks-user; range_end:; response_count:0; response_revision:7772; }","duration":"766.115635ms","start":"2026-04-20T06:06:39.729749Z","end":"2026-04-20T06:06:40.495865Z","steps":["trace[2116631150] 'agreement among raft nodes before linearized reading' (duration: 766.072004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.729733Z","time spent":"766.153727ms","remote":"127.0.0.1:51902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/barbican-ks-user\" "} {"level":"info","ts":"2026-04-20T06:06:40.495796Z","caller":"traceutil/trace.go:171","msg":"trace[411338326] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:7772; }","duration":"1.95187962s","start":"2026-04-20T06:06:38.543905Z","end":"2026-04-20T06:06:40.495785Z","steps":["trace[411338326] 'agreement among raft nodes before linearized reading' (duration: 1.951765187s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095794272s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T06:06:40.495917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"759.636159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/barbican-ks-endpoints\" ","response":"range_response_count:1 size:12817"} {"level":"warn","ts":"2026-04-20T06:06:40.495925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.54389Z","time spent":"1.952024975s","remote":"127.0.0.1:43012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-04-20T06:06:40.495946Z","caller":"traceutil/trace.go:171","msg":"trace[136840876] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:7772; }","duration":"1.095840493s","start":"2026-04-20T06:06:39.400086Z","end":"2026-04-20T06:06:40.495927Z","steps":["trace[136840876] 'agreement among raft nodes before linearized reading' (duration: 1.095759141s)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:06:40.49596Z","caller":"traceutil/trace.go:171","msg":"trace[1322464174] range","detail":"{range_begin:/registry/jobs/openstack/barbican-ks-endpoints; range_end:; response_count:1; response_revision:7772; }","duration":"759.724282ms","start":"2026-04-20T06:06:39.736225Z","end":"2026-04-20T06:06:40.495949Z","steps":["trace[1322464174] 'agreement among raft nodes before linearized reading' (duration: 759.615289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.495977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.400032Z","time spent":"1.095937655s","remote":"127.0.0.1:40748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "} {"level":"warn","ts":"2026-04-20T06:06:40.495982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:39.736202Z","time spent":"759.775503ms","remote":"127.0.0.1:51902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":12839,"request content":"key:\"/registry/jobs/openstack/barbican-ks-endpoints\" "} {"level":"info","ts":"2026-04-20T06:06:40.495639Z","caller":"traceutil/trace.go:171","msg":"trace[1010145538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7772; }","duration":"2.110383316s","start":"2026-04-20T06:06:38.385244Z","end":"2026-04-20T06:06:40.495627Z","steps":["trace[1010145538] 'agreement among raft nodes before linearized reading' (duration: 2.110273523s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.496006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.119634089s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T06:06:40.496018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.385223Z","time spent":"2.110784997s","remote":"127.0.0.1:51930","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-04-20T06:06:40.496039Z","caller":"traceutil/trace.go:171","msg":"trace[1029912019] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7772; }","duration":"2.119712561s","start":"2026-04-20T06:06:38.376317Z","end":"2026-04-20T06:06:40.49603Z","steps":["trace[1029912019] 'agreement among raft nodes before linearized reading' (duration: 2.119457854s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.496064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.376297Z","time spent":"2.119762932s","remote":"127.0.0.1:51930","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-04-20T06:06:40.496154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.125410045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:06:40.496223Z","caller":"traceutil/trace.go:171","msg":"trace[383994847] range","detail":"{range_begin:/registry/rabbitmq.com/topicpermissions/; range_end:/registry/rabbitmq.com/topicpermissions0; response_count:0; response_revision:7772; }","duration":"2.125485337s","start":"2026-04-20T06:06:38.370718Z","end":"2026-04-20T06:06:40.496203Z","steps":["trace[383994847] 'agreement among raft nodes before linearized reading' (duration: 2.124598512s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:40.496273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:38.370636Z","time spent":"2.125625182s","remote":"127.0.0.1:33668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/rabbitmq.com/topicpermissions/\" range_end:\"/registry/rabbitmq.com/topicpermissions0\" count_only:true "} {"level":"info","ts":"2026-04-20T06:06:42.533369Z","caller":"traceutil/trace.go:171","msg":"trace[397831414] linearizableReadLoop","detail":"{readStateIndex:8073; appliedIndex:8072; }","duration":"253.93759ms","start":"2026-04-20T06:06:42.279411Z","end":"2026-04-20T06:06:42.533349Z","steps":["trace[397831414] 'read index received' (duration: 253.719294ms)","trace[397831414] 'applied index is now lower than readState.Index' (duration: 217.276µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:06:42.533428Z","caller":"traceutil/trace.go:171","msg":"trace[1646804595] transaction","detail":"{read_only:false; response_revision:7796; number_of_response:1; }","duration":"359.247213ms","start":"2026-04-20T06:06:42.174135Z","end":"2026-04-20T06:06:42.533382Z","steps":["trace[1646804595] 'process raft request' (duration: 359.018026ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:42.533527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.106534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:06:42.533562Z","caller":"traceutil/trace.go:171","msg":"trace[537053710] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7796; }","duration":"254.245298ms","start":"2026-04-20T06:06:42.279304Z","end":"2026-04-20T06:06:42.53355Z","steps":["trace[537053710] 'agreement among raft nodes before linearized reading' (duration: 254.167146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:06:42.533628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:06:42.174114Z","time spent":"359.402746ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9160,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T06:06:42.537182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.640292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T06:06:42.537322Z","caller":"traceutil/trace.go:171","msg":"trace[785642571] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:7800; }","duration":"197.811127ms","start":"2026-04-20T06:06:42.339451Z","end":"2026-04-20T06:06:42.537262Z","steps":["trace[785642571] 'agreement among raft nodes before linearized reading' (duration: 197.633702ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:27.135081Z","caller":"traceutil/trace.go:171","msg":"trace[365768493] transaction","detail":"{read_only:false; response_revision:8216; number_of_response:1; }","duration":"352.557037ms","start":"2026-04-20T06:07:26.782497Z","end":"2026-04-20T06:07:27.135054Z","steps":["trace[365768493] 'process raft request' (duration: 352.3092ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:27.135059Z","caller":"traceutil/trace.go:171","msg":"trace[130097786] linearizableReadLoop","detail":"{readStateIndex:8506; appliedIndex:8505; }","duration":"297.888884ms","start":"2026-04-20T06:07:26.837137Z","end":"2026-04-20T06:07:27.135026Z","steps":["trace[130097786] 'read index received' (duration: 297.654197ms)","trace[130097786] 'applied index is now lower than readState.Index' (duration: 232.977µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:07:27.135333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.184771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T06:07:27.135345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T06:07:26.782477Z","time spent":"352.773903ms","remote":"127.0.0.1:51930","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T06:07:27.135412Z","caller":"traceutil/trace.go:171","msg":"trace[1842797178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8216; }","duration":"298.324886ms","start":"2026-04-20T06:07:26.837069Z","end":"2026-04-20T06:07:27.135393Z","steps":["trace[1842797178] 'agreement among raft nodes before linearized reading' (duration: 298.070179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:27.135591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.885772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-52h7f\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T06:07:27.13564Z","caller":"traceutil/trace.go:171","msg":"trace[269528058] range","detail":"{range_begin:/registry/pods/openstack/keepalived-52h7f; range_end:; response_count:1; response_revision:8216; }","duration":"279.945953ms","start":"2026-04-20T06:07:26.85568Z","end":"2026-04-20T06:07:27.135626Z","steps":["trace[269528058] 'agreement among raft nodes before linearized reading' (duration: 279.8286ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:27.135721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.642745ms","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-04-20T06:07:27.135772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.291154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-04-20T06:07:27.135834Z","caller":"traceutil/trace.go:171","msg":"trace[1536603815] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8216; }","duration":"294.78437ms","start":"2026-04-20T06:07:26.841031Z","end":"2026-04-20T06:07:27.135815Z","steps":["trace[1536603815] 'agreement among raft nodes before linearized reading' (duration: 294.515172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:27.135912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.9163ms","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-04-20T06:07:27.135988Z","caller":"traceutil/trace.go:171","msg":"trace[914558151] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8216; }","duration":"296.042424ms","start":"2026-04-20T06:07:26.839933Z","end":"2026-04-20T06:07:27.135975Z","steps":["trace[914558151] 'agreement among raft nodes before linearized reading' (duration: 295.778066ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:27.135836Z","caller":"traceutil/trace.go:171","msg":"trace[1827309412] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8216; }","duration":"183.47386ms","start":"2026-04-20T06:07:26.952348Z","end":"2026-04-20T06:07:27.135822Z","steps":["trace[1827309412] 'agreement among raft nodes before linearized reading' (duration: 183.280504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:27.135716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.288104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T06:07:27.136268Z","caller":"traceutil/trace.go:171","msg":"trace[622454468] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8216; }","duration":"298.886752ms","start":"2026-04-20T06:07:26.837364Z","end":"2026-04-20T06:07:27.13625Z","steps":["trace[622454468] 'agreement among raft nodes before linearized reading' (duration: 298.1293ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:27.241941Z","caller":"traceutil/trace.go:171","msg":"trace[269426287] transaction","detail":"{read_only:false; response_revision:8218; number_of_response:1; }","duration":"100.786972ms","start":"2026-04-20T06:07:27.141124Z","end":"2026-04-20T06:07:27.241911Z","steps":["trace[269426287] 'process raft request' (duration: 95.297952ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:27.24242Z","caller":"traceutil/trace.go:171","msg":"trace[934808285] linearizableReadLoop","detail":"{readStateIndex:8510; appliedIndex:8506; }","duration":"100.72923ms","start":"2026-04-20T06:07:27.141663Z","end":"2026-04-20T06:07:27.242392Z","steps":["trace[934808285] 'read index received' (duration: 20.342565ms)","trace[934808285] 'applied index is now lower than readState.Index' (duration: 80.385555ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T06:07:27.242498Z","caller":"traceutil/trace.go:171","msg":"trace[591718957] transaction","detail":"{read_only:false; response_revision:8220; number_of_response:1; }","duration":"100.839054ms","start":"2026-04-20T06:07:27.141644Z","end":"2026-04-20T06:07:27.242483Z","steps":["trace[591718957] 'process raft request' (duration: 100.598677ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:27.242538Z","caller":"traceutil/trace.go:171","msg":"trace[673579410] transaction","detail":"{read_only:false; response_revision:8219; number_of_response:1; }","duration":"101.479421ms","start":"2026-04-20T06:07:27.141033Z","end":"2026-04-20T06:07:27.242512Z","steps":["trace[673579410] 'process raft request' (duration: 100.810472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:27.242814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.72751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19444"} {"level":"info","ts":"2026-04-20T06:07:27.242863Z","caller":"traceutil/trace.go:171","msg":"trace[376771967] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8220; }","duration":"100.817523ms","start":"2026-04-20T06:07:27.142034Z","end":"2026-04-20T06:07:27.242852Z","steps":["trace[376771967] 'agreement among raft nodes before linearized reading' (duration: 100.597737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:27.243677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.993465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224171"} {"level":"info","ts":"2026-04-20T06:07:27.243757Z","caller":"traceutil/trace.go:171","msg":"trace[1937469926] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8220; }","duration":"102.071657ms","start":"2026-04-20T06:07:27.141642Z","end":"2026-04-20T06:07:27.243714Z","steps":["trace[1937469926] 'agreement among raft nodes before linearized reading' (duration: 100.947547ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:38.428281Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6117} {"level":"info","ts":"2026-04-20T06:07:38.913552Z","caller":"traceutil/trace.go:171","msg":"trace[1863486286] transaction","detail":"{read_only:false; response_revision:8274; number_of_response:1; }","duration":"150.054138ms","start":"2026-04-20T06:07:38.76345Z","end":"2026-04-20T06:07:38.913504Z","steps":["trace[1863486286] 'process raft request' (duration: 79.624485ms)","trace[1863486286] 'compare' (duration: 46.121959ms)","trace[1863486286] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/openstack/messaging-topology-operator-leader-election; req_size:552; } (duration: 24.032607ms)"],"step_count":3} {"level":"info","ts":"2026-04-20T06:07:38.913895Z","caller":"traceutil/trace.go:171","msg":"trace[456801280] transaction","detail":"{read_only:false; response_revision:8275; number_of_response:1; }","duration":"123.243815ms","start":"2026-04-20T06:07:38.790632Z","end":"2026-04-20T06:07:38.913876Z","steps":["trace[456801280] 'process raft request' (duration: 122.788253ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:38.913917Z","caller":"traceutil/trace.go:171","msg":"trace[6443762] transaction","detail":"{read_only:false; response_revision:8277; number_of_response:1; }","duration":"114.362193ms","start":"2026-04-20T06:07:38.799525Z","end":"2026-04-20T06:07:38.913887Z","steps":["trace[6443762] 'process raft request' (duration: 114.306152ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:38.914028Z","caller":"traceutil/trace.go:171","msg":"trace[421600517] transaction","detail":"{read_only:false; response_revision:8276; number_of_response:1; }","duration":"115.028581ms","start":"2026-04-20T06:07:38.798972Z","end":"2026-04-20T06:07:38.914Z","steps":["trace[421600517] 'process raft request' (duration: 114.746114ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:39.101366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6117,"took":"670.53968ms","hash":2727652355,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":23515136,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-04-20T06:07:39.101458Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2727652355,"revision":6117,"compact-revision":2995} {"level":"warn","ts":"2026-04-20T06:07:39.543923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.918762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-20T06:07:39.544032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.218238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-52h7f\" ","response":"range_response_count:1 size:6530"} {"level":"info","ts":"2026-04-20T06:07:39.544058Z","caller":"traceutil/trace.go:171","msg":"trace[1455366308] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8279; }","duration":"210.139028ms","start":"2026-04-20T06:07:39.333887Z","end":"2026-04-20T06:07:39.544026Z","steps":["trace[1455366308] 'range keys from in-memory index tree' (duration: 209.530312ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:07:39.544122Z","caller":"traceutil/trace.go:171","msg":"trace[939794723] range","detail":"{range_begin:/registry/pods/openstack/keepalived-52h7f; range_end:; response_count:1; response_revision:8279; }","duration":"200.404093ms","start":"2026-04-20T06:07:39.343696Z","end":"2026-04-20T06:07:39.5441Z","steps":["trace[939794723] 'range keys from in-memory index tree' (duration: 199.967981ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:39.544204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.453125ms","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-04-20T06:07:39.544363Z","caller":"traceutil/trace.go:171","msg":"trace[1524355682] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8279; }","duration":"233.764344ms","start":"2026-04-20T06:07:39.310546Z","end":"2026-04-20T06:07:39.54431Z","steps":["trace[1524355682] 'range keys from in-memory index tree' (duration: 233.191248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:07:39.544205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.161739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T06:07:39.544894Z","caller":"traceutil/trace.go:171","msg":"trace[669951987] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8279; }","duration":"210.9339ms","start":"2026-04-20T06:07:39.333935Z","end":"2026-04-20T06:07:39.544869Z","steps":["trace[669951987] 'range keys from in-memory index tree' (duration: 209.794369ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:08:12.488646Z","caller":"traceutil/trace.go:171","msg":"trace[245227248] transaction","detail":"{read_only:false; response_revision:8509; number_of_response:1; }","duration":"205.193223ms","start":"2026-04-20T06:08:12.283417Z","end":"2026-04-20T06:08:12.488611Z","steps":["trace[245227248] 'process raft request' (duration: 204.962047ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:08:12.536476Z","caller":"traceutil/trace.go:171","msg":"trace[502326813] transaction","detail":"{read_only:false; response_revision:8510; number_of_response:1; }","duration":"108.395125ms","start":"2026-04-20T06:08:12.428052Z","end":"2026-04-20T06:08:12.536447Z","steps":["trace[502326813] 'process raft request' (duration: 108.21001ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:08:21.613306Z","caller":"traceutil/trace.go:171","msg":"trace[1076820486] transaction","detail":"{read_only:false; response_revision:8600; number_of_response:1; }","duration":"109.085453ms","start":"2026-04-20T06:08:21.504153Z","end":"2026-04-20T06:08:21.613238Z","steps":["trace[1076820486] 'process raft request' (duration: 96.281696ms)","trace[1076820486] 'compare' (duration: 12.402237ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:08:22.029814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.657878ms","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-04-20T06:08:22.029901Z","caller":"traceutil/trace.go:171","msg":"trace[1505428858] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8603; }","duration":"127.802172ms","start":"2026-04-20T06:08:21.902081Z","end":"2026-04-20T06:08:22.029883Z","steps":["trace[1505428858] 'range keys from in-memory index tree' (duration: 127.485313ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T06:08:22.030172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.858563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-20T06:08:22.030213Z","caller":"traceutil/trace.go:171","msg":"trace[913127210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8603; }","duration":"127.954556ms","start":"2026-04-20T06:08:21.902247Z","end":"2026-04-20T06:08:22.030201Z","steps":["trace[913127210] 'range keys from in-memory index tree' (duration: 127.662598ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:08:43.238381Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023bd.wal"} {"level":"info","ts":"2026-04-20T06:09:03.306198Z","caller":"traceutil/trace.go:171","msg":"trace[2133099976] transaction","detail":"{read_only:false; response_revision:8968; number_of_response:1; }","duration":"136.029694ms","start":"2026-04-20T06:09:03.170116Z","end":"2026-04-20T06:09:03.306145Z","steps":["trace[2133099976] 'process raft request' (duration: 135.842059ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:09:41.589211Z","caller":"traceutil/trace.go:171","msg":"trace[642632898] transaction","detail":"{read_only:false; response_revision:9365; number_of_response:1; }","duration":"133.354689ms","start":"2026-04-20T06:09:41.455828Z","end":"2026-04-20T06:09:41.589183Z","steps":["trace[642632898] 'process raft request' (duration: 133.162444ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:09:41.604169Z","caller":"traceutil/trace.go:171","msg":"trace[905298177] transaction","detail":"{read_only:false; response_revision:9366; number_of_response:1; }","duration":"133.943695ms","start":"2026-04-20T06:09:41.47021Z","end":"2026-04-20T06:09:41.604154Z","steps":["trace[905298177] 'process raft request' (duration: 133.75605ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:09:41.604556Z","caller":"traceutil/trace.go:171","msg":"trace[1729504401] transaction","detail":"{read_only:false; response_revision:9367; number_of_response:1; }","duration":"134.240424ms","start":"2026-04-20T06:09:41.47029Z","end":"2026-04-20T06:09:41.60453Z","steps":["trace[1729504401] 'process raft request' (duration: 133.772861ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:09:41.604583Z","caller":"traceutil/trace.go:171","msg":"trace[431161724] transaction","detail":"{read_only:false; response_revision:9368; number_of_response:1; }","duration":"133.485282ms","start":"2026-04-20T06:09:41.471056Z","end":"2026-04-20T06:09:41.604541Z","steps":["trace[431161724] 'process raft request' (duration: 133.315197ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:09:41.604554Z","caller":"traceutil/trace.go:171","msg":"trace[1014247911] linearizableReadLoop","detail":"{readStateIndex:9694; appliedIndex:9690; }","duration":"105.835079ms","start":"2026-04-20T06:09:41.498691Z","end":"2026-04-20T06:09:41.604526Z","steps":["trace[1014247911] 'read index received' (duration: 90.364789ms)","trace[1014247911] 'applied index is now lower than readState.Index' (duration: 15.4687ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T06:09:41.604762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.059756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.192\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T06:09:41.604826Z","caller":"traceutil/trace.go:171","msg":"trace[1887726427] range","detail":"{range_begin:/registry/masterleases/199.19.213.192; range_end:; response_count:1; response_revision:9368; }","duration":"106.20404ms","start":"2026-04-20T06:09:41.49861Z","end":"2026-04-20T06:09:41.604814Z","steps":["trace[1887726427] 'agreement among raft nodes before linearized reading' (duration: 106.000855ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T06:10:21.776677Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"341a3703c39c1f5b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-20T06:10:21.7859Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-20T06:10:21.786048Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-20T06:12:38.435847Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8273} {"level":"info","ts":"2026-04-20T06:12:38.517932Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8273,"took":"79.384516ms","hash":148546088,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":24903680,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-20T06:12:38.518008Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":148546088,"revision":8273,"compact-revision":6117} {"level":"info","ts":"2026-04-20T06:17:38.441549Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10673} {"level":"info","ts":"2026-04-20T06:17:38.518366Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10673,"took":"74.080029ms","hash":3481558641,"current-db-size-bytes":58920960,"current-db-size":"59 MB","current-db-size-in-use-bytes":20467712,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-20T06:17:38.518452Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3481558641,"revision":10673,"compact-revision":8273}