{"level":"warn","ts":"2026-04-07T00:00:49.416833Z","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-07T00:00:49.416963Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.240:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.240:2380","--initial-cluster=instance=https://199.204.45.240:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.240:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.240: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-07T00:00:49.417187Z","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-07T00:00:49.417218Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-07T00:00:49.417284Z","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-07T00:00:49.418449Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"]} {"level":"info","ts":"2026-04-07T00:00:49.418655Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.240: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-07T00:00:49.424953Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.863466ms"} {"level":"info","ts":"2026-04-07T00:00:49.432719Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"4e46287fb5aa4785","cluster-id":"cae704afa9813e87"} {"level":"info","ts":"2026-04-07T00:00:49.432792Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T00:00:49.432814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 0"} {"level":"info","ts":"2026-04-07T00:00:49.432825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 4e46287fb5aa4785 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T00:00:49.432834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became follower at term 1"} {"level":"info","ts":"2026-04-07T00:00:49.433076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"warn","ts":"2026-04-07T00:00:49.440777Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T00:00:49.442782Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T00:00:49.44406Z","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-07T00:00:49.446619Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"4e46287fb5aa4785","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T00:00:49.447074Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"4e46287fb5aa4785","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T00:00:49.447179Z","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-07T00:00:49.447296Z","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-07T00:00:49.447332Z","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-07T00:00:49.447849Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 switched to configuration voters=(5640240112301918085)"} {"level":"info","ts":"2026-04-07T00:00:49.448059Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","added-peer-id":"4e46287fb5aa4785","added-peer-peer-urls":["https://199.204.45.240:2380"]} {"level":"info","ts":"2026-04-07T00:00:49.452798Z","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-07T00:00:49.452928Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-07T00:00:49.453029Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.240:2380"} {"level":"info","ts":"2026-04-07T00:00:49.453129Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"4e46287fb5aa4785","initial-advertise-peer-urls":["https://199.204.45.240:2380"],"listen-peer-urls":["https://199.204.45.240:2380"],"advertise-client-urls":["https://199.204.45.240:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.240:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T00:00:49.453167Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T00:00:49.934215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T00:00:49.93434Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T00:00:49.934397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgPreVoteResp from 4e46287fb5aa4785 at term 1"} {"level":"info","ts":"2026-04-07T00:00:49.934439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became candidate at term 2"} {"level":"info","ts":"2026-04-07T00:00:49.934488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 received MsgVoteResp from 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-07T00:00:49.934528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"4e46287fb5aa4785 became leader at term 2"} {"level":"info","ts":"2026-04-07T00:00:49.934562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 4e46287fb5aa4785 elected leader 4e46287fb5aa4785 at term 2"} {"level":"info","ts":"2026-04-07T00:00:50.04231Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"4e46287fb5aa4785","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.240:2379]}","request-path":"/0/members/4e46287fb5aa4785/attributes","cluster-id":"cae704afa9813e87","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T00:00:50.042689Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:00:50.042942Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:00:50.043149Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T00:00:50.043168Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T00:00:50.042975Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T00:00:50.046117Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T00:00:50.046884Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.240:2379"} {"level":"info","ts":"2026-04-07T00:00:50.198819Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cae704afa9813e87","local-member-id":"4e46287fb5aa4785","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:00:50.199Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T00:00:50.199058Z","caller":"traceutil/trace.go:171","msg":"trace[1149104793] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"102.057886ms","start":"2026-04-07T00:00:50.096988Z","end":"2026-04-07T00:00:50.199046Z","steps":["trace[1149104793] 'read index received' (duration: 101.791711ms)","trace[1149104793] 'applied index is now lower than readState.Index' (duration: 265.155µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:00:50.199131Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-07T00:00:50.199441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.418021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:00:50.199525Z","caller":"traceutil/trace.go:171","msg":"trace[73973116] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"102.533992ms","start":"2026-04-07T00:00:50.096983Z","end":"2026-04-07T00:00:50.199517Z","steps":["trace[73973116] 'agreement among raft nodes before linearized reading' (duration: 102.151447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:00:50.199448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.36016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T00:00:50.199591Z","caller":"traceutil/trace.go:171","msg":"trace[2013551742] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"102.552603ms","start":"2026-04-07T00:00:50.097029Z","end":"2026-04-07T00:00:50.199581Z","steps":["trace[2013551742] 'agreement among raft nodes before linearized reading' (duration: 102.331289ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:04.028845Z","caller":"traceutil/trace.go:171","msg":"trace[225742795] transaction","detail":"{read_only:false; response_revision:403; number_of_response:1; }","duration":"163.158782ms","start":"2026-04-07T00:01:03.865645Z","end":"2026-04-07T00:01:04.028803Z","steps":["trace[225742795] 'process raft request' (duration: 163.004359ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:18.928366Z","caller":"traceutil/trace.go:171","msg":"trace[257455151] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"220.380612ms","start":"2026-04-07T00:01:18.707965Z","end":"2026-04-07T00:01:18.928345Z","steps":["trace[257455151] 'process raft request' (duration: 219.737107ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:18.932706Z","caller":"traceutil/trace.go:171","msg":"trace[1212159566] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"219.695795ms","start":"2026-04-07T00:01:18.712976Z","end":"2026-04-07T00:01:18.932672Z","steps":["trace[1212159566] 'process raft request' (duration: 219.353141ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:18.932797Z","caller":"traceutil/trace.go:171","msg":"trace[1498451220] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"189.895206ms","start":"2026-04-07T00:01:18.742873Z","end":"2026-04-07T00:01:18.932768Z","steps":["trace[1498451220] 'process raft request' (duration: 189.673286ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:18.933199Z","caller":"traceutil/trace.go:171","msg":"trace[2110185108] transaction","detail":"{read_only:false; number_of_response:1; response_revision:562; }","duration":"186.50252ms","start":"2026-04-07T00:01:18.746673Z","end":"2026-04-07T00:01:18.933176Z","steps":["trace[2110185108] 'process raft request' (duration: 186.033392ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:18.933389Z","caller":"traceutil/trace.go:171","msg":"trace[64946654] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"173.178584ms","start":"2026-04-07T00:01:18.760039Z","end":"2026-04-07T00:01:18.933217Z","steps":["trace[64946654] 'process raft request' (duration: 173.039307ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:25.025938Z","caller":"traceutil/trace.go:171","msg":"trace[244169843] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"301.641515ms","start":"2026-04-07T00:01:24.724211Z","end":"2026-04-07T00:01:25.025852Z","steps":["trace[244169843] 'process raft request' (duration: 301.425197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:25.026751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:24.724191Z","time spent":"301.850763ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:01:25.049074Z","caller":"traceutil/trace.go:171","msg":"trace[1692606567] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"324.524056ms","start":"2026-04-07T00:01:24.724495Z","end":"2026-04-07T00:01:25.049019Z","steps":["trace[1692606567] 'process raft request' (duration: 324.207284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:25.049765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:24.724481Z","time spent":"325.187711ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:01:25.049893Z","caller":"traceutil/trace.go:171","msg":"trace[419168864] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"274.243429ms","start":"2026-04-07T00:01:24.775608Z","end":"2026-04-07T00:01:25.049852Z","steps":["trace[419168864] 'process raft request' (duration: 273.597625ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:25.748963Z","caller":"traceutil/trace.go:171","msg":"trace[1059047884] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:645; }","duration":"292.11797ms","start":"2026-04-07T00:01:25.456817Z","end":"2026-04-07T00:01:25.748935Z","steps":["trace[1059047884] 'read index received' (duration: 291.920083ms)","trace[1059047884] 'applied index is now lower than readState.Index' (duration: 196.867µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:01:25.749329Z","caller":"traceutil/trace.go:171","msg":"trace[1634644682] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"376.451739ms","start":"2026-04-07T00:01:25.372865Z","end":"2026-04-07T00:01:25.749317Z","steps":["trace[1634644682] 'process raft request' (duration: 374.451634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:25.749452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:25.372831Z","time spent":"376.538581ms","remote":"127.0.0.1:49910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4361,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:01:25.749722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.868228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:01:25.749826Z","caller":"traceutil/trace.go:171","msg":"trace[2037918728] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:622; }","duration":"293.011583ms","start":"2026-04-07T00:01:25.456788Z","end":"2026-04-07T00:01:25.7498Z","steps":["trace[2037918728] 'agreement among raft nodes before linearized reading' (duration: 292.837137ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:26.001226Z","caller":"traceutil/trace.go:171","msg":"trace[829848276] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"252.094781ms","start":"2026-04-07T00:01:25.749045Z","end":"2026-04-07T00:01:26.00114Z","steps":["trace[829848276] 'read index received' (duration: 245.092581ms)","trace[829848276] 'applied index is now lower than readState.Index' (duration: 7.00066ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:01:26.001239Z","caller":"traceutil/trace.go:171","msg":"trace[780440498] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"446.045679ms","start":"2026-04-07T00:01:25.555148Z","end":"2026-04-07T00:01:26.001193Z","steps":["trace[780440498] 'process raft request' (duration: 439.63973ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:26.00152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.034324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dwlc5\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-07T00:01:26.00151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.457267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:01:26.001569Z","caller":"traceutil/trace.go:171","msg":"trace[1774576004] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dwlc5; range_end:; response_count:1; response_revision:623; }","duration":"164.138938ms","start":"2026-04-07T00:01:25.837412Z","end":"2026-04-07T00:01:26.001551Z","steps":["trace[1774576004] 'agreement among raft nodes before linearized reading' (duration: 163.996043ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:26.00163Z","caller":"traceutil/trace.go:171","msg":"trace[1431353349] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"427.615812ms","start":"2026-04-07T00:01:25.573969Z","end":"2026-04-07T00:01:26.001585Z","steps":["trace[1431353349] 'agreement among raft nodes before linearized reading' (duration: 427.334552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:26.001682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:25.573948Z","time spent":"427.722826ms","remote":"127.0.0.1:49986","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":"warn","ts":"2026-04-07T00:01:26.001689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:25.555126Z","time spent":"446.292807ms","remote":"127.0.0.1:49816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:01:26.216506Z","caller":"traceutil/trace.go:171","msg":"trace[1663619459] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"192.403639ms","start":"2026-04-07T00:01:26.024074Z","end":"2026-04-07T00:01:26.216478Z","steps":["trace[1663619459] 'process raft request' (duration: 186.72456ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:01:26.220623Z","caller":"traceutil/trace.go:171","msg":"trace[687973475] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"159.458774ms","start":"2026-04-07T00:01:26.061134Z","end":"2026-04-07T00:01:26.220593Z","steps":["trace[687973475] 'process raft request' (duration: 159.374151ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:26.806473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.363821ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:01:26.806848Z","caller":"traceutil/trace.go:171","msg":"trace[1392885267] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:652; }","duration":"349.781675ms","start":"2026-04-07T00:01:26.457053Z","end":"2026-04-07T00:01:26.806834Z","steps":["trace[1392885267] 'read index received' (duration: 170.76722ms)","trace[1392885267] 'applied index is now lower than readState.Index' (duration: 179.011715ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:01:26.806841Z","caller":"traceutil/trace.go:171","msg":"trace[1646070482] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"530.619967ms","start":"2026-04-07T00:01:26.276195Z","end":"2026-04-07T00:01:26.806815Z","steps":["trace[1646070482] 'process raft request' (duration: 351.709866ms)","trace[1646070482] 'compare' (duration: 178.214746ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:01:26.807066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:26.276177Z","time spent":"530.854255ms","remote":"127.0.0.1:49800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T00:01:26.806942Z","caller":"traceutil/trace.go:171","msg":"trace[1211708219] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"528.688066ms","start":"2026-04-07T00:01:26.278229Z","end":"2026-04-07T00:01:26.806917Z","steps":["trace[1211708219] 'process raft request' (duration: 528.556381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:26.807049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.939512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:01:26.807233Z","caller":"traceutil/trace.go:171","msg":"trace[1849611515] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:631; }","duration":"350.18268ms","start":"2026-04-07T00:01:26.456999Z","end":"2026-04-07T00:01:26.807182Z","steps":["trace[1849611515] 'agreement among raft nodes before linearized reading' (duration: 349.939271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:26.807329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.810498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T00:01:26.807454Z","caller":"traceutil/trace.go:171","msg":"trace[815380433] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"169.005995ms","start":"2026-04-07T00:01:26.638419Z","end":"2026-04-07T00:01:26.807425Z","steps":["trace[815380433] 'agreement among raft nodes before linearized reading' (duration: 168.639231ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:26.807269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:26.278219Z","time spent":"528.963846ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:01:26.807352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:26.456978Z","time spent":"350.358626ms","remote":"127.0.0.1:49722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T00:01:26.806891Z","caller":"traceutil/trace.go:171","msg":"trace[2135031723] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"529.852878ms","start":"2026-04-07T00:01:26.277005Z","end":"2026-04-07T00:01:26.806857Z","steps":["trace[2135031723] 'process raft request' (duration: 529.712272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:26.808703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:26.276995Z","time spent":"531.649575ms","remote":"127.0.0.1:49974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:01:45.506024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.072144ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:01:45.50632Z","caller":"traceutil/trace.go:171","msg":"trace[521667718] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"349.788009ms","start":"2026-04-07T00:01:45.156511Z","end":"2026-04-07T00:01:45.506299Z","steps":["trace[521667718] 'process raft request' (duration: 169.357984ms)","trace[521667718] 'compare' (duration: 179.829745ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:01:45.506435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:45.156489Z","time spent":"349.908952ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:01:45.538449Z","caller":"traceutil/trace.go:171","msg":"trace[1973518530] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"379.250833ms","start":"2026-04-07T00:01:45.159174Z","end":"2026-04-07T00:01:45.538424Z","steps":["trace[1973518530] 'process raft request' (duration: 379.13784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:01:45.538642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:01:45.159163Z","time spent":"379.361166ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:03:01.825067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.169111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:03:01.825255Z","caller":"traceutil/trace.go:171","msg":"trace[1815368148] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"176.599828ms","start":"2026-04-07T00:03:01.648638Z","end":"2026-04-07T00:03:01.825238Z","steps":["trace[1815368148] 'process raft request' (duration: 176.539896ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:01.825443Z","caller":"traceutil/trace.go:171","msg":"trace[1196707227] linearizableReadLoop","detail":"{readStateIndex:1932; appliedIndex:1931; }","duration":"422.330165ms","start":"2026-04-07T00:03:01.403083Z","end":"2026-04-07T00:03:01.825413Z","steps":["trace[1196707227] 'read index received' (duration: 50.692524ms)","trace[1196707227] 'applied index is now lower than readState.Index' (duration: 371.635461ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:03:01.82557Z","caller":"traceutil/trace.go:171","msg":"trace[1125746894] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"512.716929ms","start":"2026-04-07T00:03:01.312839Z","end":"2026-04-07T00:03:01.825556Z","steps":["trace[1125746894] 'process raft request' (duration: 140.950825ms)","trace[1125746894] 'compare' (duration: 371.044608ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:03:01.825671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.312814Z","time spent":"512.782331ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:03:01.825721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.905573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:03:01.825758Z","caller":"traceutil/trace.go:171","msg":"trace[1265891198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1859; }","duration":"369.985485ms","start":"2026-04-07T00:03:01.455761Z","end":"2026-04-07T00:03:01.825747Z","steps":["trace[1265891198] 'agreement among raft nodes before linearized reading' (duration: 369.925094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:01.825788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.455743Z","time spent":"370.037106ms","remote":"127.0.0.1:49722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T00:03:01.826006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.931278ms","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-07T00:03:01.826036Z","caller":"traceutil/trace.go:171","msg":"trace[806790940] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1859; }","duration":"422.959818ms","start":"2026-04-07T00:03:01.403067Z","end":"2026-04-07T00:03:01.826026Z","steps":["trace[806790940] 'agreement among raft nodes before linearized reading' (duration: 422.847596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:01.82608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.403013Z","time spent":"423.059471ms","remote":"127.0.0.1:54688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-07T00:03:01.826086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.509628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T00:03:01.826127Z","caller":"traceutil/trace.go:171","msg":"trace[693989219] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1859; }","duration":"350.60348ms","start":"2026-04-07T00:03:01.475511Z","end":"2026-04-07T00:03:01.826114Z","steps":["trace[693989219] 'agreement among raft nodes before linearized reading' (duration: 350.447396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:01.826157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.475482Z","time spent":"350.668382ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T00:03:01.826261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.817452ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:03:01.826293Z","caller":"traceutil/trace.go:171","msg":"trace[530962637] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1859; }","duration":"362.863712ms","start":"2026-04-07T00:03:01.463419Z","end":"2026-04-07T00:03:01.826283Z","steps":["trace[530962637] 'agreement among raft nodes before linearized reading' (duration: 362.812712ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:01.826334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.463412Z","time spent":"362.904264ms","remote":"127.0.0.1:35738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-04-07T00:03:01.82635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.839784ms","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-07T00:03:01.826381Z","caller":"traceutil/trace.go:171","msg":"trace[646909976] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1859; }","duration":"163.869795ms","start":"2026-04-07T00:03:01.662502Z","end":"2026-04-07T00:03:01.826371Z","steps":["trace[646909976] 'agreement among raft nodes before linearized reading' (duration: 163.776272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:01.826542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.1463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:03:01.826575Z","caller":"traceutil/trace.go:171","msg":"trace[1491739046] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1859; }","duration":"256.239542ms","start":"2026-04-07T00:03:01.570327Z","end":"2026-04-07T00:03:01.826567Z","steps":["trace[1491739046] 'agreement among raft nodes before linearized reading' (duration: 256.187991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:02.252214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.88237ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:03:02.252534Z","caller":"traceutil/trace.go:171","msg":"trace[467693096] linearizableReadLoop","detail":"{readStateIndex:1939; appliedIndex:1934; }","duration":"351.606904ms","start":"2026-04-07T00:03:01.900909Z","end":"2026-04-07T00:03:02.252516Z","steps":["trace[467693096] 'read index received' (duration: 122.239233ms)","trace[467693096] 'applied index is now lower than readState.Index' (duration: 229.366711ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:03:02.252608Z","caller":"traceutil/trace.go:171","msg":"trace[929881941] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"419.240591ms","start":"2026-04-07T00:03:01.833356Z","end":"2026-04-07T00:03:02.252597Z","steps":["trace[929881941] 'process raft request' (duration: 189.85399ms)","trace[929881941] 'compare' (duration: 228.762938ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:03:02.252697Z","caller":"traceutil/trace.go:171","msg":"trace[13119105] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"415.600754ms","start":"2026-04-07T00:03:01.837065Z","end":"2026-04-07T00:03:02.252665Z","steps":["trace[13119105] 'process raft request' (duration: 415.40575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:02.252737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.833339Z","time spent":"419.316192ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T00:03:02.252864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.837056Z","time spent":"415.724137ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:03:02.252908Z","caller":"traceutil/trace.go:171","msg":"trace[252304821] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"419.379574ms","start":"2026-04-07T00:03:01.833521Z","end":"2026-04-07T00:03:02.2529Z","steps":["trace[252304821] 'process raft request' (duration: 418.859823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:02.252972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.83351Z","time spent":"419.425035ms","remote":"127.0.0.1:49898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:03:02.252873Z","caller":"traceutil/trace.go:171","msg":"trace[1373789513] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"418.157968ms","start":"2026-04-07T00:03:01.834702Z","end":"2026-04-07T00:03:02.25286Z","steps":["trace[1373789513] 'process raft request' (duration: 417.729818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:02.252988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.690331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T00:03:02.253046Z","caller":"traceutil/trace.go:171","msg":"trace[2147361041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1865; }","duration":"347.846074ms","start":"2026-04-07T00:03:01.905186Z","end":"2026-04-07T00:03:02.253032Z","steps":["trace[2147361041] 'agreement among raft nodes before linearized reading' (duration: 347.597599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:02.253069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.834688Z","time spent":"418.338873ms","remote":"127.0.0.1:49898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:03:02.252519Z","caller":"traceutil/trace.go:171","msg":"trace[1448991342] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"419.022107ms","start":"2026-04-07T00:03:01.833466Z","end":"2026-04-07T00:03:02.252488Z","steps":["trace[1448991342] 'process raft request' (duration: 418.838893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:02.253182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.270158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T00:03:02.253238Z","caller":"traceutil/trace.go:171","msg":"trace[526384045] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1865; }","duration":"352.368711ms","start":"2026-04-07T00:03:01.900856Z","end":"2026-04-07T00:03:02.253225Z","steps":["trace[526384045] 'agreement among raft nodes before linearized reading' (duration: 352.219187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:02.253276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.900831Z","time spent":"352.436971ms","remote":"127.0.0.1:49986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T00:03:02.253291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.905153Z","time spent":"348.098909ms","remote":"127.0.0.1:49986","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-07T00:03:02.253489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:03:01.83346Z","time spent":"419.861795ms","remote":"127.0.0.1:50000","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:03:14.011773Z","caller":"traceutil/trace.go:171","msg":"trace[1890602519] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"168.597366ms","start":"2026-04-07T00:03:13.843149Z","end":"2026-04-07T00:03:14.011747Z","steps":["trace[1890602519] 'process raft request' (duration: 168.446253ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:14.036375Z","caller":"traceutil/trace.go:171","msg":"trace[1730120923] linearizableReadLoop","detail":"{readStateIndex:2045; appliedIndex:2043; }","duration":"121.468183ms","start":"2026-04-07T00:03:13.914882Z","end":"2026-04-07T00:03:14.03635Z","steps":["trace[1730120923] 'read index received' (duration: 96.705644ms)","trace[1730120923] 'applied index is now lower than readState.Index' (duration: 24.761619ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:03:14.036438Z","caller":"traceutil/trace.go:171","msg":"trace[219398393] transaction","detail":"{read_only:false; response_revision:1967; number_of_response:1; }","duration":"169.393712ms","start":"2026-04-07T00:03:13.867021Z","end":"2026-04-07T00:03:14.036415Z","steps":["trace[219398393] 'process raft request' (duration: 169.192727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:03:14.036583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.691917ms","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-07T00:03:14.036618Z","caller":"traceutil/trace.go:171","msg":"trace[1825006127] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1967; }","duration":"121.777569ms","start":"2026-04-07T00:03:13.914828Z","end":"2026-04-07T00:03:14.036606Z","steps":["trace[1825006127] 'agreement among raft nodes before linearized reading' (duration: 121.612925ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:17.799596Z","caller":"traceutil/trace.go:171","msg":"trace[931722336] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"216.515796ms","start":"2026-04-07T00:03:17.583041Z","end":"2026-04-07T00:03:17.799556Z","steps":["trace[931722336] 'process raft request' (duration: 216.077747ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:34.926833Z","caller":"traceutil/trace.go:171","msg":"trace[852456495] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"140.099253ms","start":"2026-04-07T00:03:34.786705Z","end":"2026-04-07T00:03:34.926804Z","steps":["trace[852456495] 'process raft request' (duration: 124.874345ms)","trace[852456495] 'compare' (duration: 15.125836ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:03:40.995515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.441809ms","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-07T00:03:40.995555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.919665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T00:03:40.995613Z","caller":"traceutil/trace.go:171","msg":"trace[1370643367] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2127; }","duration":"181.599313ms","start":"2026-04-07T00:03:40.813997Z","end":"2026-04-07T00:03:40.995596Z","steps":["trace[1370643367] 'range keys from in-memory index tree' (duration: 181.266586ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:03:40.995647Z","caller":"traceutil/trace.go:171","msg":"trace[39763646] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2127; }","duration":"247.050558ms","start":"2026-04-07T00:03:40.748577Z","end":"2026-04-07T00:03:40.995627Z","steps":["trace[39763646] 'range keys from in-memory index tree' (duration: 246.750421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:00.119517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.097335ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T00:09:00.119673Z","caller":"traceutil/trace.go:171","msg":"trace[1089201523] linearizableReadLoop","detail":"{readStateIndex:4612; appliedIndex:4611; }","duration":"111.7723ms","start":"2026-04-07T00:09:00.007876Z","end":"2026-04-07T00:09:00.119648Z","steps":["trace[1089201523] 'read index received' (duration: 57.802µs)","trace[1089201523] 'applied index is now lower than readState.Index' (duration: 111.711858ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:09:00.119774Z","caller":"traceutil/trace.go:171","msg":"trace[1369609818] transaction","detail":"{read_only:false; response_revision:4436; number_of_response:1; }","duration":"161.364122ms","start":"2026-04-07T00:08:59.958392Z","end":"2026-04-07T00:09:00.119756Z","steps":["trace[1369609818] 'process raft request' (duration: 25.919199ms)","trace[1369609818] 'compare' (duration: 134.927641ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:09:00.120054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.178549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-tls-x6lhz\" ","response":"range_response_count:1 size:2456"} {"level":"info","ts":"2026-04-07T00:09:00.120111Z","caller":"traceutil/trace.go:171","msg":"trace[438378867] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-tls-x6lhz; range_end:; response_count:1; response_revision:4436; }","duration":"112.293241ms","start":"2026-04-07T00:09:00.007802Z","end":"2026-04-07T00:09:00.120096Z","steps":["trace[438378867] 'agreement among raft nodes before linearized reading' (duration: 112.057456ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:05.496335Z","caller":"traceutil/trace.go:171","msg":"trace[1993357761] transaction","detail":"{read_only:false; response_revision:4523; number_of_response:1; }","duration":"101.708646ms","start":"2026-04-07T00:09:05.394564Z","end":"2026-04-07T00:09:05.496272Z","steps":["trace[1993357761] 'process raft request' (duration: 98.955008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:06.574183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.077071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:09:06.574283Z","caller":"traceutil/trace.go:171","msg":"trace[423646033] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4582; }","duration":"119.192983ms","start":"2026-04-07T00:09:06.455069Z","end":"2026-04-07T00:09:06.574262Z","steps":["trace[423646033] 'range keys from in-memory index tree' (duration: 118.983029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:06.577129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.402966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2193165"} {"level":"info","ts":"2026-04-07T00:09:06.577215Z","caller":"traceutil/trace.go:171","msg":"trace[1701697358] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4582; }","duration":"127.527869ms","start":"2026-04-07T00:09:06.449672Z","end":"2026-04-07T00:09:06.577199Z","steps":["trace[1701697358] 'range keys from in-memory index tree' (duration: 119.630103ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:06.774023Z","caller":"traceutil/trace.go:171","msg":"trace[1683078409] linearizableReadLoop","detail":"{readStateIndex:4762; appliedIndex:4761; }","duration":"109.57366ms","start":"2026-04-07T00:09:06.664433Z","end":"2026-04-07T00:09:06.774006Z","steps":["trace[1683078409] 'read index received' (duration: 109.488159ms)","trace[1683078409] 'applied index is now lower than readState.Index' (duration: 84.681µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:09:06.774396Z","caller":"traceutil/trace.go:171","msg":"trace[1733714637] transaction","detail":"{read_only:false; response_revision:4584; number_of_response:1; }","duration":"111.723905ms","start":"2026-04-07T00:09:06.662662Z","end":"2026-04-07T00:09:06.774386Z","steps":["trace[1733714637] 'process raft request' (duration: 111.227335ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:06.774656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.207993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config\" ","response":"range_response_count:1 size:696"} {"level":"info","ts":"2026-04-07T00:09:06.778167Z","caller":"traceutil/trace.go:171","msg":"trace[1204465013] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-web-config; range_end:; response_count:1; response_revision:4584; }","duration":"113.725998ms","start":"2026-04-07T00:09:06.664417Z","end":"2026-04-07T00:09:06.778143Z","steps":["trace[1204465013] 'agreement among raft nodes before linearized reading' (duration: 110.158893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:06.774974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.074081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:09:06.778602Z","caller":"traceutil/trace.go:171","msg":"trace[1380593844] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4584; }","duration":"104.727148ms","start":"2026-04-07T00:09:06.673863Z","end":"2026-04-07T00:09:06.77859Z","steps":["trace[1380593844] 'agreement among raft nodes before linearized reading' (duration: 101.079271ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:09.223365Z","caller":"traceutil/trace.go:171","msg":"trace[657708929] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"127.660815ms","start":"2026-04-07T00:09:09.095663Z","end":"2026-04-07T00:09:09.223324Z","steps":["trace[657708929] 'process raft request' (duration: 127.496191ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:09.700638Z","caller":"traceutil/trace.go:171","msg":"trace[840331878] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"601.346235ms","start":"2026-04-07T00:09:09.099257Z","end":"2026-04-07T00:09:09.700603Z","steps":["trace[840331878] 'process raft request' (duration: 601.150451ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:09.70083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:09.099244Z","time spent":"601.484358ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4067,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:09:09.718101Z","caller":"traceutil/trace.go:171","msg":"trace[1592591216] linearizableReadLoop","detail":"{readStateIndex:4825; appliedIndex:4823; }","duration":"122.050677ms","start":"2026-04-07T00:09:09.59602Z","end":"2026-04-07T00:09:09.718071Z","steps":["trace[1592591216] 'read index received' (duration: 104.387035ms)","trace[1592591216] 'applied index is now lower than readState.Index' (duration: 17.662312ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:09:09.718291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.25449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-83627986-b7f4-47a4-bb07-4eccba934347\" ","response":"range_response_count:1 size:4082"} {"level":"info","ts":"2026-04-07T00:09:09.718336Z","caller":"traceutil/trace.go:171","msg":"trace[1456041553] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-83627986-b7f4-47a4-bb07-4eccba934347; range_end:; response_count:1; response_revision:4644; }","duration":"122.357523ms","start":"2026-04-07T00:09:09.595967Z","end":"2026-04-07T00:09:09.718325Z","steps":["trace[1456041553] 'agreement among raft nodes before linearized reading' (duration: 122.248161ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:09.718172Z","caller":"traceutil/trace.go:171","msg":"trace[677011422] transaction","detail":"{read_only:false; response_revision:4644; number_of_response:1; }","duration":"170.867463ms","start":"2026-04-07T00:09:09.547256Z","end":"2026-04-07T00:09:09.718124Z","steps":["trace[677011422] 'process raft request' (duration: 170.678638ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:15.603296Z","caller":"traceutil/trace.go:171","msg":"trace[1626075752] linearizableReadLoop","detail":"{readStateIndex:4959; appliedIndex:4958; }","duration":"146.22601ms","start":"2026-04-07T00:09:15.457049Z","end":"2026-04-07T00:09:15.603275Z","steps":["trace[1626075752] 'read index received' (duration: 142.39597ms)","trace[1626075752] 'applied index is now lower than readState.Index' (duration: 3.82898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:09:15.603421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.367502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:09:15.603442Z","caller":"traceutil/trace.go:171","msg":"trace[2055508815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4774; }","duration":"146.438304ms","start":"2026-04-07T00:09:15.456997Z","end":"2026-04-07T00:09:15.603436Z","steps":["trace[2055508815] 'agreement among raft nodes before linearized reading' (duration: 146.370002ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:15.603668Z","caller":"traceutil/trace.go:171","msg":"trace[1825577500] transaction","detail":"{read_only:false; response_revision:4774; number_of_response:1; }","duration":"338.440471ms","start":"2026-04-07T00:09:15.265204Z","end":"2026-04-07T00:09:15.603645Z","steps":["trace[1825577500] 'process raft request' (duration: 334.338634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:15.603915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:15.265182Z","time spent":"338.649734ms","remote":"127.0.0.1:48092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7567,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:09:22.561071Z","caller":"traceutil/trace.go:171","msg":"trace[1241215789] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"133.536807ms","start":"2026-04-07T00:09:22.427507Z","end":"2026-04-07T00:09:22.561044Z","steps":["trace[1241215789] 'process raft request' (duration: 95.330592ms)","trace[1241215789] 'compare' (duration: 38.009071ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:09:22.561313Z","caller":"traceutil/trace.go:171","msg":"trace[451221863] linearizableReadLoop","detail":"{readStateIndex:5061; appliedIndex:5059; }","duration":"132.906744ms","start":"2026-04-07T00:09:22.428382Z","end":"2026-04-07T00:09:22.561289Z","steps":["trace[451221863] 'read index received' (duration: 94.529426ms)","trace[451221863] 'applied index is now lower than readState.Index' (duration: 38.376188ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T00:09:22.56155Z","caller":"traceutil/trace.go:171","msg":"trace[2011135520] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"133.71836ms","start":"2026-04-07T00:09:22.427817Z","end":"2026-04-07T00:09:22.561536Z","steps":["trace[2011135520] 'process raft request' (duration: 133.158959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:22.561569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.525024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T00:09:22.561621Z","caller":"traceutil/trace.go:171","msg":"trace[1143094833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4874; }","duration":"105.661408ms","start":"2026-04-07T00:09:22.455944Z","end":"2026-04-07T00:09:22.561605Z","steps":["trace[1143094833] 'agreement among raft nodes before linearized reading' (duration: 105.566356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:22.561684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.269811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0\" ","response":"range_response_count:1 size:650"} {"level":"info","ts":"2026-04-07T00:09:22.56177Z","caller":"traceutil/trace.go:171","msg":"trace[160152322] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-0; range_end:; response_count:1; response_revision:4874; }","duration":"133.388493ms","start":"2026-04-07T00:09:22.42836Z","end":"2026-04-07T00:09:22.561748Z","steps":["trace[160152322] 'agreement among raft nodes before linearized reading' (duration: 133.118748ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:09:30.080899Z","caller":"traceutil/trace.go:171","msg":"trace[838712867] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"384.46817ms","start":"2026-04-07T00:09:29.69641Z","end":"2026-04-07T00:09:30.080879Z","steps":["trace[838712867] 'process raft request' (duration: 384.325457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:30.081023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:29.696393Z","time spent":"384.568932ms","remote":"127.0.0.1:49800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T00:09:30.081005Z","caller":"traceutil/trace.go:171","msg":"trace[814767262] linearizableReadLoop","detail":"{readStateIndex:5147; appliedIndex:5147; }","duration":"384.386549ms","start":"2026-04-07T00:09:29.696582Z","end":"2026-04-07T00:09:30.080969Z","steps":["trace[814767262] 'read index received' (duration: 384.368208ms)","trace[814767262] 'applied index is now lower than readState.Index' (duration: 15.641µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T00:09:30.081511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.909349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:1455"} {"level":"info","ts":"2026-04-07T00:09:30.082201Z","caller":"traceutil/trace.go:171","msg":"trace[1554604986] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4957; }","duration":"385.602094ms","start":"2026-04-07T00:09:29.696567Z","end":"2026-04-07T00:09:30.082169Z","steps":["trace[1554604986] 'agreement among raft nodes before linearized reading' (duration: 384.539542ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T00:09:30.082401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T00:09:29.696533Z","time spent":"385.833188ms","remote":"127.0.0.1:49924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":1478,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-keystone\" "} {"level":"info","ts":"2026-04-07T00:09:30.088159Z","caller":"traceutil/trace.go:171","msg":"trace[1257995865] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"286.481434ms","start":"2026-04-07T00:09:29.801607Z","end":"2026-04-07T00:09:30.088089Z","steps":["trace[1257995865] 'process raft request' (duration: 286.29011ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T00:10:50.069206Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2926} {"level":"info","ts":"2026-04-07T00:10:50.17078Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2926,"took":"100.464412ms","hash":1967982030,"current-db-size-bytes":54005760,"current-db-size":"54 MB","current-db-size-in-use-bytes":29319168,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-07T00:10:50.170839Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1967982030,"revision":2926,"compact-revision":-1} {"level":"info","ts":"2026-04-07T00:15:50.077616Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5605} {"level":"info","ts":"2026-04-07T00:15:50.162335Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5605,"took":"83.322235ms","hash":1149178890,"current-db-size-bytes":54005760,"current-db-size":"54 MB","current-db-size-in-use-bytes":18358272,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-07T00:15:50.162409Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1149178890,"revision":5605,"compact-revision":2926}