{"level":"warn","ts":"2026-05-07T13:09:52.517263Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-07T13:09:52.517383Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.204: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.204:2380","--initial-cluster=instance=https://199.19.213.204:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.204:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.204:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-07T13:09:52.517486Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-07T13:09:52.517507Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.204:2380"]}
{"level":"info","ts":"2026-05-07T13:09:52.51753Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-07T13:09:52.51855Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.204:2379"]}
{"level":"info","ts":"2026-05-07T13:09:52.518668Z","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.19.213.204:2380"],"listen-peer-urls":["https://199.19.213.204:2380"],"advertise-client-urls":["https://199.19.213.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.204:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-07T13:09:52.523799Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.567181ms"}
{"level":"info","ts":"2026-05-07T13:09:52.529621Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"7e62df5d1e8b96ac","cluster-id":"502b8ba4e757e03a"}
{"level":"info","ts":"2026-05-07T13:09:52.529697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac switched to configuration voters=()"}
{"level":"info","ts":"2026-05-07T13:09:52.52972Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became follower at term 0"}
{"level":"info","ts":"2026-05-07T13:09:52.529735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 7e62df5d1e8b96ac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-07T13:09:52.529761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became follower at term 1"}
{"level":"info","ts":"2026-05-07T13:09:52.5298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac switched to configuration voters=(9107086987533981356)"}
{"level":"warn","ts":"2026-05-07T13:09:52.53626Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-07T13:09:52.537631Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-07T13:09:52.538669Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-07T13:09:52.541157Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"7e62df5d1e8b96ac","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-07T13:09:52.541394Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"7e62df5d1e8b96ac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-07T13:09:52.54154Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-07T13:09:52.541636Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-07T13:09:52.54165Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-07T13:09:52.542172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac switched to configuration voters=(9107086987533981356)"}
{"level":"info","ts":"2026-05-07T13:09:52.542416Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"502b8ba4e757e03a","local-member-id":"7e62df5d1e8b96ac","added-peer-id":"7e62df5d1e8b96ac","added-peer-peer-urls":["https://199.19.213.204:2380"]}
{"level":"info","ts":"2026-05-07T13:09:52.545839Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-07T13:09:52.546004Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"7e62df5d1e8b96ac","initial-advertise-peer-urls":["https://199.19.213.204:2380"],"listen-peer-urls":["https://199.19.213.204:2380"],"advertise-client-urls":["https://199.19.213.204:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.204:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-07T13:09:52.546027Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-07T13:09:52.546068Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.204:2380"}
{"level":"info","ts":"2026-05-07T13:09:52.546076Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.204:2380"}
{"level":"info","ts":"2026-05-07T13:09:53.330382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac is starting a new election at term 1"}
{"level":"info","ts":"2026-05-07T13:09:53.330443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-07T13:09:53.330487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac received MsgPreVoteResp from 7e62df5d1e8b96ac at term 1"}
{"level":"info","ts":"2026-05-07T13:09:53.330507Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became candidate at term 2"}
{"level":"info","ts":"2026-05-07T13:09:53.330518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac received MsgVoteResp from 7e62df5d1e8b96ac at term 2"}
{"level":"info","ts":"2026-05-07T13:09:53.330538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"7e62df5d1e8b96ac became leader at term 2"}
{"level":"info","ts":"2026-05-07T13:09:53.330558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 7e62df5d1e8b96ac elected leader 7e62df5d1e8b96ac at term 2"}
{"level":"info","ts":"2026-05-07T13:09:53.332933Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T13:09:53.333626Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"7e62df5d1e8b96ac","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.204:2379]}","request-path":"/0/members/7e62df5d1e8b96ac/attributes","cluster-id":"502b8ba4e757e03a","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-07T13:09:53.333647Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-07T13:09:53.333743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-07T13:09:53.333907Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"502b8ba4e757e03a","local-member-id":"7e62df5d1e8b96ac","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T13:09:53.333893Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-07T13:09:53.334024Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-07T13:09:53.334065Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T13:09:53.334114Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-07T13:09:53.337468Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.204:2379"}
{"level":"info","ts":"2026-05-07T13:09:53.337525Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-05-07T13:09:58.234336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.103685ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10857226535511200578 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/specs/kube-system/kube-dns\" mod_revision:0 > success:<request_put:<key:\"/registry/services/specs/kube-system/kube-dns\" value_size:1143 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-07T13:09:58.234456Z","caller":"traceutil/trace.go:171","msg":"trace[1751832049] transaction","detail":"{read_only:false; number_of_response:0; response_revision:242; }","duration":"161.274055ms","start":"2026-05-07T13:09:58.073174Z","end":"2026-05-07T13:09:58.234448Z","steps":["trace[1751832049] 'process raft request'  (duration: 161.247305ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.234563Z","caller":"traceutil/trace.go:171","msg":"trace[1001574535] transaction","detail":"{read_only:false; response_revision:242; number_of_response:1; }","duration":"208.100895ms","start":"2026-05-07T13:09:58.026423Z","end":"2026-05-07T13:09:58.234524Z","steps":["trace[1001574535] 'process raft request'  (duration: 12.509757ms)","trace[1001574535] 'compare'  (duration: 194.988224ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:09:58.234562Z","caller":"traceutil/trace.go:171","msg":"trace[1583042879] linearizableReadLoop","detail":"{readStateIndex:248; appliedIndex:247; }","duration":"190.744658ms","start":"2026-05-07T13:09:58.043788Z","end":"2026-05-07T13:09:58.234533Z","steps":["trace[1583042879] 'read index received'  (duration: 56.48µs)","trace[1583042879] 'applied index is now lower than readState.Index'  (duration: 190.685778ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:09:58.234717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.911529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T13:09:58.234757Z","caller":"traceutil/trace.go:171","msg":"trace[1081606165] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:242; }","duration":"190.995679ms","start":"2026-05-07T13:09:58.043751Z","end":"2026-05-07T13:09:58.234747Z","steps":["trace[1081606165] 'agreement among raft nodes before linearized reading'  (duration: 190.869658ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.484927Z","caller":"traceutil/trace.go:171","msg":"trace[381221720] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"389.720516ms","start":"2026-05-07T13:09:58.095157Z","end":"2026-05-07T13:09:58.484878Z","steps":["trace[381221720] 'process raft request'  (duration: 389.564235ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.484974Z","caller":"traceutil/trace.go:171","msg":"trace[1392378649] transaction","detail":"{read_only:false; response_revision:243; number_of_response:1; }","duration":"411.63839ms","start":"2026-05-07T13:09:58.073305Z","end":"2026-05-07T13:09:58.484944Z","steps":["trace[1392378649] 'process raft request'  (duration: 349.768778ms)","trace[1392378649] 'compare'  (duration: 61.53598ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:09:58.485025Z","caller":"traceutil/trace.go:171","msg":"trace[711361462] transaction","detail":"{read_only:false; response_revision:246; number_of_response:1; }","duration":"388.70196ms","start":"2026-05-07T13:09:58.096298Z","end":"2026-05-07T13:09:58.485Z","steps":["trace[711361462] 'process raft request'  (duration: 388.487138ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.485068Z","caller":"traceutil/trace.go:171","msg":"trace[803222872] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"388.78745ms","start":"2026-05-07T13:09:58.096241Z","end":"2026-05-07T13:09:58.485028Z","steps":["trace[803222872] 'process raft request'  (duration: 388.520398ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.485129Z","caller":"traceutil/trace.go:171","msg":"trace[1849649833] transaction","detail":"{read_only:false; number_of_response:0; response_revision:246; }","duration":"388.597728ms","start":"2026-05-07T13:09:58.096486Z","end":"2026-05-07T13:09:58.485083Z","steps":["trace[1849649833] 'process raft request'  (duration: 388.393237ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:09:58.48513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.096294Z","time spent":"388.7925ms","remote":"127.0.0.1:59938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-apiserver-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-apiserver-instance\" value_size:5824 >> failure:<>"}
{"level":"warn","ts":"2026-05-07T13:09:58.485119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.095137Z","time spent":"389.890427ms","remote":"127.0.0.1:59938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/etcd-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/etcd-instance\" value_size:3917 >> failure:<>"}
{"level":"warn","ts":"2026-05-07T13:09:58.485196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.096233Z","time spent":"388.903411ms","remote":"127.0.0.1:59938","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-scheduler-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-scheduler-instance\" value_size:2847 >> failure:<>"}
{"level":"info","ts":"2026-05-07T13:09:58.485177Z","caller":"traceutil/trace.go:171","msg":"trace[25326655] transaction","detail":"{read_only:false; number_of_response:0; response_revision:246; }","duration":"388.542038ms","start":"2026-05-07T13:09:58.09659Z","end":"2026-05-07T13:09:58.485132Z","steps":["trace[25326655] 'process raft request'  (duration: 388.331177ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:09:58.485232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.09648Z","time spent":"388.71473ms","remote":"127.0.0.1:59938","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-vip-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-vip-instance\" value_size:3401 >> failure:<>"}
{"level":"warn","ts":"2026-05-07T13:09:58.485133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.073281Z","time spent":"411.760002ms","remote":"127.0.0.1:59836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":642,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/events/default/instance.18ad4a8d2c050738\" mod_revision:0 > success:<request_put:<key:\"/registry/events/default/instance.18ad4a8d2c050738\" value_size:574 lease:1633854498656424714 >> failure:<>"}
{"level":"warn","ts":"2026-05-07T13:09:58.485304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.096571Z","time spent":"388.682729ms","remote":"127.0.0.1:59938","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare:<target:MOD key:\"/registry/pods/kube-system/kube-controller-manager-instance\" mod_revision:0 > success:<request_put:<key:\"/registry/pods/kube-system/kube-controller-manager-instance\" value_size:5431 >> failure:<>"}
{"level":"info","ts":"2026-05-07T13:09:58.484973Z","caller":"traceutil/trace.go:171","msg":"trace[1429478300] linearizableReadLoop","detail":"{readStateIndex:255; appliedIndex:249; }","duration":"249.310528ms","start":"2026-05-07T13:09:58.235642Z","end":"2026-05-07T13:09:58.484953Z","steps":["trace[1429478300] 'read index received'  (duration: 187.442426ms)","trace[1429478300] 'applied index is now lower than readState.Index'  (duration: 61.867172ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:09:58.485402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.744671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"}
{"level":"info","ts":"2026-05-07T13:09:58.485463Z","caller":"traceutil/trace.go:171","msg":"trace[1969348982] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:246; }","duration":"249.810941ms","start":"2026-05-07T13:09:58.235637Z","end":"2026-05-07T13:09:58.485448Z","steps":["trace[1969348982] 'agreement among raft nodes before linearized reading'  (duration: 249.675351ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.632125Z","caller":"traceutil/trace.go:171","msg":"trace[1918934817] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"391.411696ms","start":"2026-05-07T13:09:58.240682Z","end":"2026-05-07T13:09:58.632094Z","steps":["trace[1918934817] 'process raft request'  (duration: 378.850208ms)","trace[1918934817] 'compare'  (duration: 12.374846ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:09:58.632168Z","caller":"traceutil/trace.go:171","msg":"trace[1604406280] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"142.297149ms","start":"2026-05-07T13:09:58.489849Z","end":"2026-05-07T13:09:58.632146Z","steps":["trace[1604406280] 'process raft request'  (duration: 142.248729ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.632199Z","caller":"traceutil/trace.go:171","msg":"trace[1822265597] linearizableReadLoop","detail":"{readStateIndex:256; appliedIndex:255; }","duration":"146.798396ms","start":"2026-05-07T13:09:58.48538Z","end":"2026-05-07T13:09:58.632179Z","steps":["trace[1822265597] 'read index received'  (duration: 134.162928ms)","trace[1822265597] 'applied index is now lower than readState.Index'  (duration: 12.633638ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:09:58.632361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.235293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"}
{"level":"warn","ts":"2026-05-07T13:09:58.632435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.651669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"}
{"level":"info","ts":"2026-05-07T13:09:58.632475Z","caller":"traceutil/trace.go:171","msg":"trace[1043565344] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:248; }","duration":"394.325503ms","start":"2026-05-07T13:09:58.238081Z","end":"2026-05-07T13:09:58.632406Z","steps":["trace[1043565344] 'agreement among raft nodes before linearized reading'  (duration: 394.178923ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:09:58.632511Z","caller":"traceutil/trace.go:171","msg":"trace[1232042111] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:248; }","duration":"145.75498ms","start":"2026-05-07T13:09:58.486737Z","end":"2026-05-07T13:09:58.632491Z","steps":["trace[1232042111] 'agreement among raft nodes before linearized reading'  (duration: 145.600569ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:09:58.632539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.8083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"}
{"level":"warn","ts":"2026-05-07T13:09:58.632576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.238069Z","time spent":"394.490144ms","remote":"127.0.0.1:59860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":373,"request content":"key:\"/registry/namespaces/kube-system\" "}
{"level":"info","ts":"2026-05-07T13:09:58.632606Z","caller":"traceutil/trace.go:171","msg":"trace[667911666] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:248; }","duration":"145.907991ms","start":"2026-05-07T13:09:58.486684Z","end":"2026-05-07T13:09:58.632592Z","steps":["trace[667911666] 'agreement among raft nodes before linearized reading'  (duration: 145.618079ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:09:58.632686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.839862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"}
{"level":"info","ts":"2026-05-07T13:09:58.632748Z","caller":"traceutil/trace.go:171","msg":"trace[528416415] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:248; }","duration":"142.955642ms","start":"2026-05-07T13:09:58.489778Z","end":"2026-05-07T13:09:58.632734Z","steps":["trace[528416415] 'agreement among raft nodes before linearized reading'  (duration: 142.56283ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:09:58.632993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:09:58.24067Z","time spent":"391.534526ms","remote":"127.0.0.1:59858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1934,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/configmaps/kube-system/kube-proxy\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/kube-system/kube-proxy\" value_size:1883 >> failure:<>"}
{"level":"warn","ts":"2026-05-07T13:10:25.738519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.351364ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T13:10:25.738656Z","caller":"traceutil/trace.go:171","msg":"trace[2031266712] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:547; }","duration":"241.509495ms","start":"2026-05-07T13:10:25.497125Z","end":"2026-05-07T13:10:25.738634Z","steps":["trace[2031266712] 'range keys from in-memory index tree'  (duration: 241.314834ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:10:25.991552Z","caller":"traceutil/trace.go:171","msg":"trace[1926266856] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"374.764248ms","start":"2026-05-07T13:10:25.616771Z","end":"2026-05-07T13:10:25.991535Z","steps":["trace[1926266856] 'process raft request'  (duration: 374.545706ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:10:25.991796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.961654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-05-07T13:10:25.991865Z","caller":"traceutil/trace.go:171","msg":"trace[1340027336] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:548; }","duration":"113.082835ms","start":"2026-05-07T13:10:25.878768Z","end":"2026-05-07T13:10:25.991851Z","steps":["trace[1340027336] 'agreement among raft nodes before linearized reading'  (duration: 112.871524ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:10:25.991926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:10:25.61675Z","time spent":"374.877418ms","remote":"127.0.0.1:60034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" mod_revision:415 > success:<request_put:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" value_size:600 >> failure:<request_range:<key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" > >"}
{"level":"info","ts":"2026-05-07T13:10:25.991499Z","caller":"traceutil/trace.go:171","msg":"trace[218088920] linearizableReadLoop","detail":"{readStateIndex:569; appliedIndex:568; }","duration":"112.632532ms","start":"2026-05-07T13:10:25.878839Z","end":"2026-05-07T13:10:25.991472Z","steps":["trace[218088920] 'read index received'  (duration: 112.441161ms)","trace[218088920] 'applied index is now lower than readState.Index'  (duration: 190.341µs)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:10:30.337259Z","caller":"traceutil/trace.go:171","msg":"trace[1987898431] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"265.187744ms","start":"2026-05-07T13:10:30.072047Z","end":"2026-05-07T13:10:30.337235Z","steps":["trace[1987898431] 'process raft request'  (duration: 265.049763ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:10:30.54761Z","caller":"traceutil/trace.go:171","msg":"trace[1751530603] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"463.78053ms","start":"2026-05-07T13:10:30.083723Z","end":"2026-05-07T13:10:30.547504Z","steps":["trace[1751530603] 'read index received'  (duration: 254.05669ms)","trace[1751530603] 'applied index is now lower than readState.Index'  (duration: 209.72226ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:10:30.547868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.118711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zj87g\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-07T13:10:30.547922Z","caller":"traceutil/trace.go:171","msg":"trace[270504857] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zj87g; range_end:; response_count:1; response_revision:579; }","duration":"464.205352ms","start":"2026-05-07T13:10:30.083688Z","end":"2026-05-07T13:10:30.547893Z","steps":["trace[270504857] 'agreement among raft nodes before linearized reading'  (duration: 464.015251ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:10:30.547962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:10:30.08367Z","time spent":"464.281223ms","remote":"127.0.0.1:59938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16987,"request content":"key:\"/registry/pods/kube-system/cilium-zj87g\" "}
{"level":"info","ts":"2026-05-07T13:10:30.548255Z","caller":"traceutil/trace.go:171","msg":"trace[1690004782] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"468.659943ms","start":"2026-05-07T13:10:30.079579Z","end":"2026-05-07T13:10:30.548239Z","steps":["trace[1690004782] 'process raft request'  (duration: 464.221492ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:10:30.548367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:10:30.079539Z","time spent":"468.743024ms","remote":"127.0.0.1:59846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:573 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036229 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"info","ts":"2026-05-07T13:12:11.718099Z","caller":"traceutil/trace.go:171","msg":"trace[43018173] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1920; }","duration":"152.955966ms","start":"2026-05-07T13:12:11.565116Z","end":"2026-05-07T13:12:11.718072Z","steps":["trace[43018173] 'read index received'  (duration: 150.783975ms)","trace[43018173] 'applied index is now lower than readState.Index'  (duration: 2.170831ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:12:11.718153Z","caller":"traceutil/trace.go:171","msg":"trace[922399421] transaction","detail":"{read_only:false; response_revision:1847; number_of_response:1; }","duration":"154.263196ms","start":"2026-05-07T13:12:11.563858Z","end":"2026-05-07T13:12:11.718121Z","steps":["trace[922399421] 'process raft request'  (duration: 151.552432ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:12:11.718357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.217942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0f812612-6548-4180-b722-a92689f242d0\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-07T13:12:11.718399Z","caller":"traceutil/trace.go:171","msg":"trace[386746559] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0f812612-6548-4180-b722-a92689f242d0; range_end:; response_count:1; response_revision:1847; }","duration":"153.302694ms","start":"2026-05-07T13:12:11.565084Z","end":"2026-05-07T13:12:11.718387Z","steps":["trace[386746559] 'agreement among raft nodes before linearized reading'  (duration: 153.14667ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:12:11.7832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.806015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0f812612-6548-4180-b722-a92689f242d0\" ","response":"range_response_count:1 size:3627"}
{"level":"info","ts":"2026-05-07T13:12:11.783279Z","caller":"traceutil/trace.go:171","msg":"trace[1821724303] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0f812612-6548-4180-b722-a92689f242d0; range_end:; response_count:1; response_revision:1848; }","duration":"177.933109ms","start":"2026-05-07T13:12:11.60533Z","end":"2026-05-07T13:12:11.783263Z","steps":["trace[1821724303] 'agreement among raft nodes before linearized reading'  (duration: 177.713713ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:12:26.232621Z","caller":"traceutil/trace.go:171","msg":"trace[1778533298] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"120.903693ms","start":"2026-05-07T13:12:26.111699Z","end":"2026-05-07T13:12:26.232603Z","steps":["trace[1778533298] 'process raft request'  (duration: 120.799571ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:12:49.958606Z","caller":"traceutil/trace.go:171","msg":"trace[980479522] transaction","detail":"{read_only:false; response_revision:2105; number_of_response:1; }","duration":"231.427151ms","start":"2026-05-07T13:12:49.727161Z","end":"2026-05-07T13:12:49.958589Z","steps":["trace[980479522] 'process raft request'  (duration: 231.254258ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:12:49.984454Z","caller":"traceutil/trace.go:171","msg":"trace[1551539370] transaction","detail":"{read_only:false; response_revision:2106; number_of_response:1; }","duration":"109.114133ms","start":"2026-05-07T13:12:49.875294Z","end":"2026-05-07T13:12:49.984408Z","steps":["trace[1551539370] 'process raft request'  (duration: 108.818957ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:12:50.14303Z","caller":"traceutil/trace.go:171","msg":"trace[748232400] transaction","detail":"{read_only:false; response_revision:2110; number_of_response:1; }","duration":"103.015843ms","start":"2026-05-07T13:12:50.039984Z","end":"2026-05-07T13:12:50.143Z","steps":["trace[748232400] 'process raft request'  (duration: 102.726368ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:12:50.143285Z","caller":"traceutil/trace.go:171","msg":"trace[580840081] transaction","detail":"{read_only:false; response_revision:2109; number_of_response:1; }","duration":"115.628076ms","start":"2026-05-07T13:12:50.027129Z","end":"2026-05-07T13:12:50.142757Z","steps":["trace[580840081] 'process raft request'  (duration: 26.941867ms)","trace[580840081] 'compare'  (duration: 88.440415ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:12:50.353466Z","caller":"traceutil/trace.go:171","msg":"trace[1575589281] transaction","detail":"{read_only:false; response_revision:2111; number_of_response:1; }","duration":"205.477277ms","start":"2026-05-07T13:12:50.147964Z","end":"2026-05-07T13:12:50.353441Z","steps":["trace[1575589281] 'process raft request'  (duration: 205.288353ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:12:50.615795Z","caller":"traceutil/trace.go:171","msg":"trace[1706197476] transaction","detail":"{read_only:false; response_revision:2112; number_of_response:1; }","duration":"304.530498ms","start":"2026-05-07T13:12:50.311232Z","end":"2026-05-07T13:12:50.615763Z","steps":["trace[1706197476] 'process raft request'  (duration: 247.089851ms)","trace[1706197476] 'compare'  (duration: 57.244053ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:12:50.616629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:12:50.311207Z","time spent":"304.690731ms","remote":"127.0.0.1:60034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:2101 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-07T13:12:50.836781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.461266ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10857226535511204381 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:2102 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-07T13:12:50.836909Z","caller":"traceutil/trace.go:171","msg":"trace[2101573070] transaction","detail":"{read_only:false; response_revision:2113; number_of_response:1; }","duration":"216.607103ms","start":"2026-05-07T13:12:50.620273Z","end":"2026-05-07T13:12:50.83688Z","steps":["trace[2101573070] 'process raft request'  (duration: 101.960565ms)","trace[2101573070] 'compare'  (duration: 114.129099ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:14:14.227301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.130947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18ad4ac42197b971\" ","response":"range_response_count:1 size:781"}
{"level":"info","ts":"2026-05-07T13:14:14.227389Z","caller":"traceutil/trace.go:171","msg":"trace[1459486350] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18ad4ac42197b971; range_end:; response_count:1; response_revision:2671; }","duration":"106.230158ms","start":"2026-05-07T13:14:14.12114Z","end":"2026-05-07T13:14:14.22737Z","steps":["trace[1459486350] 'range keys from in-memory index tree'  (duration: 105.948054ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:14:14.495654Z","caller":"traceutil/trace.go:171","msg":"trace[144831541] transaction","detail":"{read_only:false; response_revision:2673; number_of_response:1; }","duration":"191.718357ms","start":"2026-05-07T13:14:14.303906Z","end":"2026-05-07T13:14:14.495624Z","steps":["trace[144831541] 'process raft request'  (duration: 191.508345ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:14:14.684813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.162507ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10857226535511205739 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2662 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-07T13:14:14.685054Z","caller":"traceutil/trace.go:171","msg":"trace[129357934] linearizableReadLoop","detail":"{readStateIndex:2778; appliedIndex:2776; }","duration":"117.067404ms","start":"2026-05-07T13:14:14.567941Z","end":"2026-05-07T13:14:14.685008Z","steps":["trace[129357934] 'read index received'  (duration: 31.42µs)","trace[129357934] 'applied index is now lower than readState.Index'  (duration: 117.034974ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:14:14.68515Z","caller":"traceutil/trace.go:171","msg":"trace[236688698] transaction","detail":"{read_only:false; response_revision:2674; number_of_response:1; }","duration":"379.362363ms","start":"2026-05-07T13:14:14.305745Z","end":"2026-05-07T13:14:14.685107Z","steps":["trace[236688698] 'process raft request'  (duration: 228.808311ms)","trace[236688698] 'compare'  (duration: 150.030855ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:14:14.685399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.452078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"}
{"level":"info","ts":"2026-05-07T13:14:14.685442Z","caller":"traceutil/trace.go:171","msg":"trace[380063804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2675; }","duration":"117.532939ms","start":"2026-05-07T13:14:14.567899Z","end":"2026-05-07T13:14:14.685432Z","steps":["trace[380063804] 'agreement among raft nodes before linearized reading'  (duration: 117.329356ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:14:14.685388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:14:14.305731Z","time spent":"379.518785ms","remote":"127.0.0.1:60034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:2662 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:478 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-07T13:14:14.68518Z","caller":"traceutil/trace.go:171","msg":"trace[670104870] transaction","detail":"{read_only:false; response_revision:2675; number_of_response:1; }","duration":"377.869194ms","start":"2026-05-07T13:14:14.307299Z","end":"2026-05-07T13:14:14.685168Z","steps":["trace[670104870] 'process raft request'  (duration: 377.60598ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:14:14.685568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.314976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"}
{"level":"warn","ts":"2026-05-07T13:14:14.685626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:14:14.30729Z","time spent":"378.263078ms","remote":"127.0.0.1:60034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:2663 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-07T13:14:14.685652Z","caller":"traceutil/trace.go:171","msg":"trace[1904154753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2675; }","duration":"117.443428ms","start":"2026-05-07T13:14:14.56819Z","end":"2026-05-07T13:14:14.685633Z","steps":["trace[1904154753] 'agreement among raft nodes before linearized reading'  (duration: 117.202705ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:16:13.539133Z","caller":"traceutil/trace.go:171","msg":"trace[532835049] transaction","detail":"{read_only:false; response_revision:3391; number_of_response:1; }","duration":"253.102005ms","start":"2026-05-07T13:16:13.286011Z","end":"2026-05-07T13:16:13.539113Z","steps":["trace[532835049] 'process raft request'  (duration: 252.985281ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:16:13.638378Z","caller":"traceutil/trace.go:171","msg":"trace[840757490] transaction","detail":"{read_only:false; response_revision:3392; number_of_response:1; }","duration":"350.675943ms","start":"2026-05-07T13:16:13.287686Z","end":"2026-05-07T13:16:13.638362Z","steps":["trace[840757490] 'process raft request'  (duration: 349.926047ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:16:13.638547Z","caller":"traceutil/trace.go:171","msg":"trace[1919980173] transaction","detail":"{read_only:false; response_revision:3393; number_of_response:1; }","duration":"334.877735ms","start":"2026-05-07T13:16:13.303657Z","end":"2026-05-07T13:16:13.638535Z","steps":["trace[1919980173] 'process raft request'  (duration: 334.668178ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:16:13.638553Z","caller":"traceutil/trace.go:171","msg":"trace[842774607] linearizableReadLoop","detail":"{readStateIndex:3523; appliedIndex:3520; }","duration":"250.172156ms","start":"2026-05-07T13:16:13.388346Z","end":"2026-05-07T13:16:13.638518Z","steps":["trace[842774607] 'read index received'  (duration: 150.697584ms)","trace[842774607] 'applied index is now lower than readState.Index'  (duration: 99.473012ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:16:13.638665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:16:13.303644Z","time spent":"334.930548ms","remote":"127.0.0.1:60034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" mod_revision:3380 > success:<request_put:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" value_size:465 >> failure:<request_range:<key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" > >"}
{"level":"warn","ts":"2026-05-07T13:16:13.63869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:16:13.287652Z","time spent":"350.777436ms","remote":"127.0.0.1:60034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:3378 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >"}
{"level":"warn","ts":"2026-05-07T13:16:13.638728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.406433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"}
{"level":"info","ts":"2026-05-07T13:16:13.638786Z","caller":"traceutil/trace.go:171","msg":"trace[1254761676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3393; }","duration":"250.504857ms","start":"2026-05-07T13:16:13.388266Z","end":"2026-05-07T13:16:13.638771Z","steps":["trace[1254761676] 'agreement among raft nodes before linearized reading'  (duration: 250.337642ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.224401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.880673ms","expected-duration":"100ms","prefix":"","request":"header:<ID:10857226535511210289 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" mod_revision:4561 > success:<request_put:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" value_size:3206 >> failure:<request_range:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-07T13:17:56.224591Z","caller":"traceutil/trace.go:171","msg":"trace[2116138901] transaction","detail":"{read_only:false; response_revision:4590; number_of_response:1; }","duration":"562.087259ms","start":"2026-05-07T13:17:55.66248Z","end":"2026-05-07T13:17:56.224567Z","steps":["trace[2116138901] 'process raft request'  (duration: 433.9622ms)","trace[2116138901] 'compare'  (duration: 127.583856ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:17:56.224628Z","caller":"traceutil/trace.go:171","msg":"trace[185489261] transaction","detail":"{read_only:false; response_revision:4592; number_of_response:1; }","duration":"116.973388ms","start":"2026-05-07T13:17:56.107637Z","end":"2026-05-07T13:17:56.22461Z","steps":["trace[185489261] 'process raft request'  (duration: 116.938877ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.224714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:17:55.66246Z","time spent":"562.186702ms","remote":"127.0.0.1:41326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3281,"response count":0,"response size":38,"request content":"compare:<target:MOD key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" mod_revision:4561 > success:<request_put:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" value_size:3206 >> failure:<request_range:<key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" > >"}
{"level":"info","ts":"2026-05-07T13:17:56.2248Z","caller":"traceutil/trace.go:171","msg":"trace[560099028] linearizableReadLoop","detail":"{readStateIndex:4763; appliedIndex:4762; }","duration":"562.046298ms","start":"2026-05-07T13:17:55.662746Z","end":"2026-05-07T13:17:56.224792Z","steps":["trace[560099028] 'read index received'  (duration: 433.710174ms)","trace[560099028] 'applied index is now lower than readState.Index'  (duration: 128.335294ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:17:56.224977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.476336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T13:17:56.225003Z","caller":"traceutil/trace.go:171","msg":"trace[68733395] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:4592; }","duration":"550.526758ms","start":"2026-05-07T13:17:55.674467Z","end":"2026-05-07T13:17:56.224994Z","steps":["trace[68733395] 'agreement among raft nodes before linearized reading'  (duration: 550.487557ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.225023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:17:55.674451Z","time spent":"550.566448ms","remote":"127.0.0.1:59890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" "}
{"level":"warn","ts":"2026-05-07T13:17:56.225035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"562.277153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"}
{"level":"info","ts":"2026-05-07T13:17:56.225085Z","caller":"traceutil/trace.go:171","msg":"trace[1102466274] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4592; }","duration":"562.342165ms","start":"2026-05-07T13:17:55.662728Z","end":"2026-05-07T13:17:56.22507Z","steps":["trace[1102466274] 'agreement among raft nodes before linearized reading'  (duration: 562.203121ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.225119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:17:55.662722Z","time spent":"562.389396ms","remote":"127.0.0.1:59846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":1,"response size":730,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" "}
{"level":"warn","ts":"2026-05-07T13:17:56.225197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.650779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-07T13:17:56.225255Z","caller":"traceutil/trace.go:171","msg":"trace[1402224200] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4592; }","duration":"279.747882ms","start":"2026-05-07T13:17:55.945492Z","end":"2026-05-07T13:17:56.22524Z","steps":["trace[1402224200] 'agreement among raft nodes before linearized reading'  (duration: 279.626679ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:17:56.225282Z","caller":"traceutil/trace.go:171","msg":"trace[673540898] transaction","detail":"{read_only:false; response_revision:4591; number_of_response:1; }","duration":"255.767158ms","start":"2026-05-07T13:17:55.969501Z","end":"2026-05-07T13:17:56.225268Z","steps":["trace[673540898] 'process raft request'  (duration: 254.99138ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.225702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.066712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-07T13:17:56.225739Z","caller":"traceutil/trace.go:171","msg":"trace[1553884352] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:4592; }","duration":"399.130454ms","start":"2026-05-07T13:17:55.826594Z","end":"2026-05-07T13:17:56.225724Z","steps":["trace[1553884352] 'agreement among raft nodes before linearized reading'  (duration: 399.036452ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.225768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:17:55.826576Z","time spent":"399.184005ms","remote":"127.0.0.1:59968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":69,"response size":29,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "}
{"level":"warn","ts":"2026-05-07T13:17:56.225864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.221243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194901"}
{"level":"info","ts":"2026-05-07T13:17:56.225896Z","caller":"traceutil/trace.go:171","msg":"trace[217245412] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4592; }","duration":"381.280065ms","start":"2026-05-07T13:17:55.844606Z","end":"2026-05-07T13:17:56.225887Z","steps":["trace[217245412] 'agreement among raft nodes before linearized reading'  (duration: 380.620659ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.225908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.124559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-07T13:17:56.225921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:17:55.844588Z","time spent":"381.324195ms","remote":"127.0.0.1:59858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2194923,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "}
{"level":"info","ts":"2026-05-07T13:17:56.225939Z","caller":"traceutil/trace.go:171","msg":"trace[524341795] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:4592; }","duration":"507.18612ms","start":"2026-05-07T13:17:55.718744Z","end":"2026-05-07T13:17:56.22593Z","steps":["trace[524341795] 'agreement among raft nodes before linearized reading'  (duration: 507.134679ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.225973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-07T13:17:55.718728Z","time spent":"507.234851ms","remote":"127.0.0.1:45088","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "}
{"level":"warn","ts":"2026-05-07T13:17:56.226551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.900338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-07T13:17:56.226618Z","caller":"traceutil/trace.go:171","msg":"trace[680929101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4592; }","duration":"229.027512ms","start":"2026-05-07T13:17:55.997577Z","end":"2026-05-07T13:17:56.226604Z","steps":["trace[680929101] 'agreement among raft nodes before linearized reading'  (duration: 228.890558ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.226786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.8481ms","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-05-07T13:17:56.226837Z","caller":"traceutil/trace.go:171","msg":"trace[836035528] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4592; }","duration":"185.920962ms","start":"2026-05-07T13:17:56.040904Z","end":"2026-05-07T13:17:56.226825Z","steps":["trace[836035528] 'agreement among raft nodes before linearized reading'  (duration: 185.803749ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:17:56.59714Z","caller":"traceutil/trace.go:171","msg":"trace[229044948] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"178.59505ms","start":"2026-05-07T13:17:56.418532Z","end":"2026-05-07T13:17:56.597127Z","steps":["trace[229044948] 'process raft request'  (duration: 178.357975ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:17:56.597145Z","caller":"traceutil/trace.go:171","msg":"trace[1605679312] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"191.171744ms","start":"2026-05-07T13:17:56.405955Z","end":"2026-05-07T13:17:56.597127Z","steps":["trace[1605679312] 'process raft request'  (duration: 190.877787ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:17:56.59727Z","caller":"traceutil/trace.go:171","msg":"trace[1617794067] transaction","detail":"{read_only:false; response_revision:4611; number_of_response:1; }","duration":"193.419227ms","start":"2026-05-07T13:17:56.403745Z","end":"2026-05-07T13:17:56.597164Z","steps":["trace[1617794067] 'process raft request'  (duration: 110.697161ms)","trace[1617794067] 'compare'  (duration: 82.261835ms)"],"step_count":2}
{"level":"info","ts":"2026-05-07T13:17:56.597009Z","caller":"traceutil/trace.go:171","msg":"trace[759393175] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"137.811876ms","start":"2026-05-07T13:17:56.459174Z","end":"2026-05-07T13:17:56.596986Z","steps":["trace[759393175] 'process raft request'  (duration: 137.766855ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-07T13:17:56.597805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.782898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4849"}
{"level":"warn","ts":"2026-05-07T13:17:56.597877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.714537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"}
{"level":"info","ts":"2026-05-07T13:17:56.597902Z","caller":"traceutil/trace.go:171","msg":"trace[127766266] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:4614; }","duration":"185.891111ms","start":"2026-05-07T13:17:56.411988Z","end":"2026-05-07T13:17:56.597879Z","steps":["trace[127766266] 'agreement among raft nodes before linearized reading'  (duration: 185.640475ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:17:56.597925Z","caller":"traceutil/trace.go:171","msg":"trace[996940755] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:4614; }","duration":"191.78883ms","start":"2026-05-07T13:17:56.406122Z","end":"2026-05-07T13:17:56.597911Z","steps":["trace[996940755] 'agreement among raft nodes before linearized reading'  (duration: 191.620976ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:17:56.597499Z","caller":"traceutil/trace.go:171","msg":"trace[570475143] linearizableReadLoop","detail":"{readStateIndex:4787; appliedIndex:4784; }","duration":"142.794593ms","start":"2026-05-07T13:17:56.454691Z","end":"2026-05-07T13:17:56.597486Z","steps":["trace[570475143] 'read index received'  (duration: 59.735628ms)","trace[570475143] 'applied index is now lower than readState.Index'  (duration: 83.057345ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-07T13:17:56.598487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.659239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:9494"}
{"level":"info","ts":"2026-05-07T13:17:56.598534Z","caller":"traceutil/trace.go:171","msg":"trace[1576484676] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4614; }","duration":"139.738971ms","start":"2026-05-07T13:17:56.458781Z","end":"2026-05-07T13:17:56.59852Z","steps":["trace[1576484676] 'agreement among raft nodes before linearized reading'  (duration: 139.575047ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:17:59.461636Z","caller":"traceutil/trace.go:171","msg":"trace[674373858] transaction","detail":"{read_only:false; response_revision:4660; number_of_response:1; }","duration":"165.44514ms","start":"2026-05-07T13:17:59.296152Z","end":"2026-05-07T13:17:59.461597Z","steps":["trace[674373858] 'process raft request'  (duration: 165.272986ms)"],"step_count":1}
{"level":"info","ts":"2026-05-07T13:19:53.367162Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2879}
{"level":"info","ts":"2026-05-07T13:19:53.448439Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2879,"took":"79.933282ms","hash":508147003,"current-db-size-bytes":54644736,"current-db-size":"55 MB","current-db-size-in-use-bytes":29507584,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-07T13:19:53.448501Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":508147003,"revision":2879,"compact-revision":-1}
{"level":"info","ts":"2026-05-07T13:24:53.373372Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5604}
{"level":"info","ts":"2026-05-07T13:24:53.462752Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5604,"took":"87.700563ms","hash":1857281621,"current-db-size-bytes":54644736,"current-db-size":"55 MB","current-db-size-in-use-bytes":18305024,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-07T13:24:53.462841Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1857281621,"revision":5604,"compact-revision":2879}