{"level":"warn","ts":"2026-09-18T22:55:40.835831Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-18T22:55:40.835993Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.79:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.79:2380","--initial-cluster=instance=https://162.253.55.79:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.79:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.79:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-09-18T22:55:40.836115Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-09-18T22:55:40.83613Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.79:2380"]}
{"level":"info","ts":"2026-09-18T22:55:40.836166Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-18T22:55:40.837204Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"]}
{"level":"info","ts":"2026-09-18T22:55:40.837358Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.79:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-09-18T22:55:40.843454Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.73961ms"}
{"level":"info","ts":"2026-09-18T22:55:40.850354Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"401ca643156fc5da","cluster-id":"e9f568c3681bb0d0"}
{"level":"info","ts":"2026-09-18T22:55:40.850437Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=()"}
{"level":"info","ts":"2026-09-18T22:55:40.850459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 0"}
{"level":"info","ts":"2026-09-18T22:55:40.850474Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 401ca643156fc5da [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-09-18T22:55:40.850483Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became follower at term 1"}
{"level":"info","ts":"2026-09-18T22:55:40.850521Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"}
{"level":"warn","ts":"2026-09-18T22:55:40.8689Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-09-18T22:55:40.871604Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-09-18T22:55:40.873064Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-09-18T22:55:40.876206Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"401ca643156fc5da","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-09-18T22:55:40.87639Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-18T22:55:40.87655Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-18T22:55:40.876585Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-09-18T22:55:40.876564Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"401ca643156fc5da","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-09-18T22:55:40.879548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da switched to configuration voters=(4619750124827952602)"}
{"level":"info","ts":"2026-09-18T22:55:40.89162Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","added-peer-id":"401ca643156fc5da","added-peer-peer-urls":["https://162.253.55.79:2380"]}
{"level":"info","ts":"2026-09-18T22:55:40.893689Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-09-18T22:55:40.89398Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.79:2380"}
{"level":"info","ts":"2026-09-18T22:55:40.894031Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.79:2380"}
{"level":"info","ts":"2026-09-18T22:55:40.894899Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"401ca643156fc5da","initial-advertise-peer-urls":["https://162.253.55.79:2380"],"listen-peer-urls":["https://162.253.55.79:2380"],"advertise-client-urls":["https://162.253.55.79:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.79:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-09-18T22:55:40.89497Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-09-18T22:55:41.151163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da is starting a new election at term 1"}
{"level":"info","ts":"2026-09-18T22:55:41.151267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became pre-candidate at term 1"}
{"level":"info","ts":"2026-09-18T22:55:41.151514Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgPreVoteResp from 401ca643156fc5da at term 1"}
{"level":"info","ts":"2026-09-18T22:55:41.15158Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became candidate at term 2"}
{"level":"info","ts":"2026-09-18T22:55:41.151709Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da received MsgVoteResp from 401ca643156fc5da at term 2"}
{"level":"info","ts":"2026-09-18T22:55:41.151738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"401ca643156fc5da became leader at term 2"}
{"level":"info","ts":"2026-09-18T22:55:41.151787Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 401ca643156fc5da elected leader 401ca643156fc5da at term 2"}
{"level":"info","ts":"2026-09-18T22:55:41.155117Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"401ca643156fc5da","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.79:2379]}","request-path":"/0/members/401ca643156fc5da/attributes","cluster-id":"e9f568c3681bb0d0","publish-timeout":"7s"}
{"level":"info","ts":"2026-09-18T22:55:41.155171Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-18T22:55:41.155779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T22:55:41.156638Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-09-18T22:55:41.156955Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e9f568c3681bb0d0","local-member-id":"401ca643156fc5da","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T22:55:41.157121Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T22:55:41.157175Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-09-18T22:55:41.157307Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-09-18T22:55:41.157458Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-09-18T22:55:41.159014Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-09-18T22:55:41.160005Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.79:2379"}
{"level":"info","ts":"2026-09-18T22:56:26.844269Z","caller":"traceutil/trace.go:171","msg":"trace[63582994] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"111.367422ms","start":"2026-09-18T22:56:26.732868Z","end":"2026-09-18T22:56:26.844236Z","steps":["trace[63582994] 'process raft request'  (duration: 110.660309ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:56:27.010106Z","caller":"traceutil/trace.go:171","msg":"trace[207643758] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"152.175021ms","start":"2026-09-18T22:56:26.857906Z","end":"2026-09-18T22:56:27.010081Z","steps":["trace[207643758] 'read index received'  (duration: 151.201749ms)","trace[207643758] 'applied index is now lower than readState.Index'  (duration: 972.182µs)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:56:27.010226Z","caller":"traceutil/trace.go:171","msg":"trace[822990490] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"173.292765ms","start":"2026-09-18T22:56:26.836919Z","end":"2026-09-18T22:56:27.010212Z","steps":["trace[822990490] 'process raft request'  (duration: 172.572311ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:56:27.010719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.783131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-18T22:56:27.010916Z","caller":"traceutil/trace.go:171","msg":"trace[1256888164] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"153.003218ms","start":"2026-09-18T22:56:26.857861Z","end":"2026-09-18T22:56:27.010865Z","steps":["trace[1256888164] 'agreement among raft nodes before linearized reading'  (duration: 152.642056ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:56:27.235333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.674994ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14256884277086074680 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:577 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T22:56:27.235562Z","caller":"traceutil/trace.go:171","msg":"trace[113127546] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"218.79638ms","start":"2026-09-18T22:56:27.016744Z","end":"2026-09-18T22:56:27.23554Z","steps":["trace[113127546] 'process raft request'  (duration: 218.716097ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:56:27.23561Z","caller":"traceutil/trace.go:171","msg":"trace[1523665795] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"218.966236ms","start":"2026-09-18T22:56:27.016569Z","end":"2026-09-18T22:56:27.235536Z","steps":["trace[1523665795] 'process raft request'  (duration: 61.257649ms)","trace[1523665795] 'compare'  (duration: 156.539638ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:56:27.24729Z","caller":"traceutil/trace.go:171","msg":"trace[2024030967] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"160.180208ms","start":"2026-09-18T22:56:27.086904Z","end":"2026-09-18T22:56:27.247084Z","steps":["trace[2024030967] 'process raft request'  (duration: 160.059864ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:56:27.549634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.910429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T22:56:27.549706Z","caller":"traceutil/trace.go:171","msg":"trace[209205021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"187.041544ms","start":"2026-09-18T22:56:27.36265Z","end":"2026-09-18T22:56:27.549691Z","steps":["trace[209205021] 'range keys from in-memory index tree'  (duration: 186.826707ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:56:27.549761Z","caller":"traceutil/trace.go:171","msg":"trace[1644446069] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"181.692788ms","start":"2026-09-18T22:56:27.368034Z","end":"2026-09-18T22:56:27.549727Z","steps":["trace[1644446069] 'process raft request'  (duration: 155.533416ms)","trace[1644446069] 'compare'  (duration: 26.022447ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:56:28.156447Z","caller":"traceutil/trace.go:171","msg":"trace[1761349596] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"483.03587ms","start":"2026-09-18T22:56:27.673387Z","end":"2026-09-18T22:56:28.156422Z","steps":["trace[1761349596] 'process raft request'  (duration: 482.485052ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:56:28.157361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T22:56:27.673363Z","time spent":"483.156764ms","remote":"127.0.0.1:36448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:591 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036209 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-09-18T22:57:15.137125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.471425ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14256884277086075778 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-svcs-lock\" mod_revision:1154 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" value_size:371 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-svcs-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T22:57:15.13722Z","caller":"traceutil/trace.go:171","msg":"trace[1059404054] linearizableReadLoop","detail":"{readStateIndex:1207; appliedIndex:1206; }","duration":"123.044856ms","start":"2026-09-18T22:57:15.014162Z","end":"2026-09-18T22:57:15.137207Z","steps":["trace[1059404054] 'read index received'  (duration: 6.333887ms)","trace[1059404054] 'applied index is now lower than readState.Index'  (duration: 116.710039ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T22:57:15.13735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.188149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"}
{"level":"info","ts":"2026-09-18T22:57:15.137365Z","caller":"traceutil/trace.go:171","msg":"trace[1326584104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1167; }","duration":"123.23895ms","start":"2026-09-18T22:57:15.014122Z","end":"2026-09-18T22:57:15.137361Z","steps":["trace[1326584104] 'agreement among raft nodes before linearized reading'  (duration: 123.130598ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:57:15.13744Z","caller":"traceutil/trace.go:171","msg":"trace[1047218193] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"276.281734ms","start":"2026-09-18T22:57:14.861109Z","end":"2026-09-18T22:57:15.13739Z","steps":["trace[1047218193] 'process raft request'  (duration: 159.475492ms)","trace[1047218193] 'compare'  (duration: 116.147038ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T22:58:07.340874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.310961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-29618feb-f063-4469-8dc5-3c19fc975260\" ","response":"range_response_count:1 size:3626"}
{"level":"info","ts":"2026-09-18T22:58:07.340987Z","caller":"traceutil/trace.go:171","msg":"trace[1723925584] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-29618feb-f063-4469-8dc5-3c19fc975260; range_end:; response_count:1; response_revision:1852; }","duration":"180.466904ms","start":"2026-09-18T22:58:07.160495Z","end":"2026-09-18T22:58:07.340961Z","steps":["trace[1723925584] 'range keys from in-memory index tree'  (duration: 180.113278ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:58:07.499676Z","caller":"traceutil/trace.go:171","msg":"trace[848877871] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"137.157762ms","start":"2026-09-18T22:58:07.362496Z","end":"2026-09-18T22:58:07.499654Z","steps":["trace[848877871] 'read index received'  (duration: 136.933429ms)","trace[848877871] 'applied index is now lower than readState.Index'  (duration: 223.253µs)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:58:07.499746Z","caller":"traceutil/trace.go:171","msg":"trace[953154860] transaction","detail":"{read_only:false; response_revision:1853; number_of_response:1; }","duration":"148.785191ms","start":"2026-09-18T22:58:07.350939Z","end":"2026-09-18T22:58:07.499725Z","steps":["trace[953154860] 'process raft request'  (duration: 148.562468ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:58:07.499823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.321224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T22:58:07.499861Z","caller":"traceutil/trace.go:171","msg":"trace[86990692] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1853; }","duration":"137.416166ms","start":"2026-09-18T22:58:07.362435Z","end":"2026-09-18T22:58:07.499852Z","steps":["trace[86990692] 'agreement among raft nodes before linearized reading'  (duration: 137.342395ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:58:07.837693Z","caller":"traceutil/trace.go:171","msg":"trace[1248540308] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"236.924364ms","start":"2026-09-18T22:58:07.600744Z","end":"2026-09-18T22:58:07.837668Z","steps":["trace[1248540308] 'process raft request'  (duration: 232.834638ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:58:07.837974Z","caller":"traceutil/trace.go:171","msg":"trace[551754535] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"237.154637ms","start":"2026-09-18T22:58:07.6008Z","end":"2026-09-18T22:58:07.837954Z","steps":["trace[551754535] 'process raft request'  (duration: 236.827483ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:58:42.202171Z","caller":"traceutil/trace.go:171","msg":"trace[426105599] linearizableReadLoop","detail":"{readStateIndex:2184; appliedIndex:2183; }","duration":"105.873189ms","start":"2026-09-18T22:58:42.096278Z","end":"2026-09-18T22:58:42.202151Z","steps":["trace[426105599] 'read index received'  (duration: 105.665887ms)","trace[426105599] 'applied index is now lower than readState.Index'  (duration: 206.452µs)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:58:42.202252Z","caller":"traceutil/trace.go:171","msg":"trace[1600799593] transaction","detail":"{read_only:false; response_revision:2099; number_of_response:1; }","duration":"146.396106ms","start":"2026-09-18T22:58:42.055826Z","end":"2026-09-18T22:58:42.202222Z","steps":["trace[1600799593] 'process raft request'  (duration: 146.201704ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:58:42.202406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.125042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-09-18T22:58:42.20288Z","caller":"traceutil/trace.go:171","msg":"trace[1919723770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2099; }","duration":"106.656038ms","start":"2026-09-18T22:58:42.096214Z","end":"2026-09-18T22:58:42.20287Z","steps":["trace[1919723770] 'agreement among raft nodes before linearized reading'  (duration: 106.076182ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:58:42.582265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.680058ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14256884277086077747 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2090 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T22:58:42.582462Z","caller":"traceutil/trace.go:171","msg":"trace[2070807816] linearizableReadLoop","detail":"{readStateIndex:2187; appliedIndex:2184; }","duration":"356.655227ms","start":"2026-09-18T22:58:42.225792Z","end":"2026-09-18T22:58:42.582447Z","steps":["trace[2070807816] 'read index received'  (duration: 37.150088ms)","trace[2070807816] 'applied index is now lower than readState.Index'  (duration: 319.503699ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:58:42.582549Z","caller":"traceutil/trace.go:171","msg":"trace[1491676307] transaction","detail":"{read_only:false; response_revision:2102; number_of_response:1; }","duration":"374.33158ms","start":"2026-09-18T22:58:42.208208Z","end":"2026-09-18T22:58:42.58254Z","steps":["trace[1491676307] 'process raft request'  (duration: 374.146788ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:58:42.582632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T22:58:42.208204Z","time spent":"374.397011ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2089 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:430 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >"}
{"level":"info","ts":"2026-09-18T22:58:42.582652Z","caller":"traceutil/trace.go:171","msg":"trace[1232629033] transaction","detail":"{read_only:false; response_revision:2101; number_of_response:1; }","duration":"374.454572ms","start":"2026-09-18T22:58:42.208172Z","end":"2026-09-18T22:58:42.582627Z","steps":["trace[1232629033] 'process raft request'  (duration: 195.325829ms)","trace[1232629033] 'compare'  (duration: 178.452225ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T22:58:42.582793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.023951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-09-18T22:58:42.582821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T22:58:42.208163Z","time spent":"374.559513ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:2090 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:412 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-09-18T22:58:42.58287Z","caller":"traceutil/trace.go:171","msg":"trace[431052361] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:2103; }","duration":"357.133343ms","start":"2026-09-18T22:58:42.225713Z","end":"2026-09-18T22:58:42.582847Z","steps":["trace[431052361] 'agreement among raft nodes before linearized reading'  (duration: 356.987591ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:58:42.582832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.28666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"}
{"level":"warn","ts":"2026-09-18T22:58:42.582938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T22:58:42.225694Z","time spent":"357.228973ms","remote":"127.0.0.1:38694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "}
{"level":"info","ts":"2026-09-18T22:58:42.582978Z","caller":"traceutil/trace.go:171","msg":"trace[2134178885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2103; }","duration":"282.471573ms","start":"2026-09-18T22:58:42.300493Z","end":"2026-09-18T22:58:42.582964Z","steps":["trace[2134178885] 'agreement among raft nodes before linearized reading'  (duration: 282.23651ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:58:42.583001Z","caller":"traceutil/trace.go:171","msg":"trace[2075669699] transaction","detail":"{read_only:false; response_revision:2103; number_of_response:1; }","duration":"338.443007ms","start":"2026-09-18T22:58:42.244518Z","end":"2026-09-18T22:58:42.582961Z","steps":["trace[2075669699] 'process raft request'  (duration: 337.885711ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:58:42.58305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.803403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T22:58:42.583083Z","caller":"traceutil/trace.go:171","msg":"trace[595909075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2103; }","duration":"220.869953ms","start":"2026-09-18T22:58:42.362202Z","end":"2026-09-18T22:58:42.583072Z","steps":["trace[595909075] 'agreement among raft nodes before linearized reading'  (duration: 220.823593ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:58:42.583164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T22:58:42.244486Z","time spent":"338.589669ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2091 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:458 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >"}
{"level":"warn","ts":"2026-09-18T22:59:20.945053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.254746ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14256884277086078292 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" mod_revision:2305 > success:<request_put:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" value_size:459 >> failure:<request_range:<key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T22:59:20.945155Z","caller":"traceutil/trace.go:171","msg":"trace[1033202975] linearizableReadLoop","detail":"{readStateIndex:2408; appliedIndex:2407; }","duration":"125.929435ms","start":"2026-09-18T22:59:20.819211Z","end":"2026-09-18T22:59:20.94514Z","steps":["trace[1033202975] 'read index received'  (duration: 10.378176ms)","trace[1033202975] 'applied index is now lower than readState.Index'  (duration: 115.550149ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:59:20.945235Z","caller":"traceutil/trace.go:171","msg":"trace[1470239102] transaction","detail":"{read_only:false; response_revision:2314; number_of_response:1; }","duration":"163.156145ms","start":"2026-09-18T22:59:20.782067Z","end":"2026-09-18T22:59:20.945224Z","steps":["trace[1470239102] 'process raft request'  (duration: 47.623046ms)","trace[1470239102] 'compare'  (duration: 114.947063ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T22:59:20.94559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.378319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"info","ts":"2026-09-18T22:59:20.945725Z","caller":"traceutil/trace.go:171","msg":"trace[415498840] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2314; }","duration":"126.589412ms","start":"2026-09-18T22:59:20.819102Z","end":"2026-09-18T22:59:20.945691Z","steps":["trace[415498840] 'agreement among raft nodes before linearized reading'  (duration: 126.194638ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:21.010462Z","caller":"traceutil/trace.go:171","msg":"trace[1456602291] transaction","detail":"{read_only:false; response_revision:2315; number_of_response:1; }","duration":"145.123491ms","start":"2026-09-18T22:59:20.865299Z","end":"2026-09-18T22:59:21.010422Z","steps":["trace[1456602291] 'process raft request'  (duration: 144.857078ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:59:21.010565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.681442ms","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-09-18T22:59:21.010669Z","caller":"traceutil/trace.go:171","msg":"trace[1308538720] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2315; }","duration":"168.843383ms","start":"2026-09-18T22:59:20.841804Z","end":"2026-09-18T22:59:21.010647Z","steps":["trace[1308538720] 'agreement among raft nodes before linearized reading'  (duration: 168.54508ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:59:21.222826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.581475ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14256884277086078295 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:2306 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:431 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T22:59:21.223093Z","caller":"traceutil/trace.go:171","msg":"trace[266005359] transaction","detail":"{read_only:false; response_revision:2316; number_of_response:1; }","duration":"272.492496ms","start":"2026-09-18T22:59:20.950554Z","end":"2026-09-18T22:59:21.223046Z","steps":["trace[266005359] 'process raft request'  (duration: 110.566077ms)","trace[266005359] 'compare'  (duration: 161.366373ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:59:21.223128Z","caller":"traceutil/trace.go:171","msg":"trace[354156959] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"207.437762ms","start":"2026-09-18T22:59:21.015662Z","end":"2026-09-18T22:59:21.2231Z","steps":["trace[354156959] 'process raft request'  (duration: 207.313801ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:21.223533Z","caller":"traceutil/trace.go:171","msg":"trace[1621896046] transaction","detail":"{read_only:false; response_revision:2318; number_of_response:1; }","duration":"207.563873ms","start":"2026-09-18T22:59:21.015945Z","end":"2026-09-18T22:59:21.223509Z","steps":["trace[1621896046] 'process raft request'  (duration: 207.104319ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:21.223651Z","caller":"traceutil/trace.go:171","msg":"trace[504482103] transaction","detail":"{read_only:false; response_revision:2319; number_of_response:1; }","duration":"165.203432ms","start":"2026-09-18T22:59:21.058429Z","end":"2026-09-18T22:59:21.223632Z","steps":["trace[504482103] 'process raft request'  (duration: 164.99969ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:21.223629Z","caller":"traceutil/trace.go:171","msg":"trace[2132728174] linearizableReadLoop","detail":"{readStateIndex:2413; appliedIndex:2409; }","duration":"153.865506ms","start":"2026-09-18T22:59:21.069743Z","end":"2026-09-18T22:59:21.223609Z","steps":["trace[2132728174] 'read index received'  (duration: 133.517659ms)","trace[2132728174] 'applied index is now lower than readState.Index'  (duration: 20.346647ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T22:59:21.224059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.289801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5460"}
{"level":"info","ts":"2026-09-18T22:59:21.224137Z","caller":"traceutil/trace.go:171","msg":"trace[1276713441] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2319; }","duration":"154.429032ms","start":"2026-09-18T22:59:21.069686Z","end":"2026-09-18T22:59:21.224115Z","steps":["trace[1276713441] 'agreement among raft nodes before linearized reading'  (duration: 154.19272ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:21.78246Z","caller":"traceutil/trace.go:171","msg":"trace[359002400] linearizableReadLoop","detail":"{readStateIndex:2414; appliedIndex:2413; }","duration":"306.721523ms","start":"2026-09-18T22:59:21.475712Z","end":"2026-09-18T22:59:21.782433Z","steps":["trace[359002400] 'read index received'  (duration: 306.43818ms)","trace[359002400] 'applied index is now lower than readState.Index'  (duration: 282.233µs)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:59:21.782734Z","caller":"traceutil/trace.go:171","msg":"trace[130768439] transaction","detail":"{read_only:false; response_revision:2320; number_of_response:1; }","duration":"417.166457ms","start":"2026-09-18T22:59:21.36554Z","end":"2026-09-18T22:59:21.782707Z","steps":["trace[130768439] 'process raft request'  (duration: 416.713143ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:59:21.782894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T22:59:21.365512Z","time spent":"417.283609ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:2256 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-09-18T22:59:21.782931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.208468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-09-18T22:59:21.782986Z","caller":"traceutil/trace.go:171","msg":"trace[254164310] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2320; }","duration":"307.300829ms","start":"2026-09-18T22:59:21.475669Z","end":"2026-09-18T22:59:21.782969Z","steps":["trace[254164310] 'agreement among raft nodes before linearized reading'  (duration: 306.877545ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T22:59:21.783032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T22:59:21.475647Z","time spent":"307.371029ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-09-18T22:59:23.141376Z","caller":"traceutil/trace.go:171","msg":"trace[883946329] transaction","detail":"{read_only:false; response_revision:2326; number_of_response:1; }","duration":"189.887835ms","start":"2026-09-18T22:59:22.951454Z","end":"2026-09-18T22:59:23.141342Z","steps":["trace[883946329] 'process raft request'  (duration: 159.585418ms)","trace[883946329] 'compare'  (duration: 30.060735ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:59:23.141626Z","caller":"traceutil/trace.go:171","msg":"trace[566503870] transaction","detail":"{read_only:false; response_revision:2327; number_of_response:1; }","duration":"126.141178ms","start":"2026-09-18T22:59:23.015474Z","end":"2026-09-18T22:59:23.141615Z","steps":["trace[566503870] 'process raft request'  (duration: 125.817745ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:27.376188Z","caller":"traceutil/trace.go:171","msg":"trace[1667929780] transaction","detail":"{read_only:false; response_revision:2348; number_of_response:1; }","duration":"152.059936ms","start":"2026-09-18T22:59:27.224098Z","end":"2026-09-18T22:59:27.376157Z","steps":["trace[1667929780] 'process raft request'  (duration: 56.246544ms)","trace[1667929780] 'compare'  (duration: 95.226017ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T22:59:27.667032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.416922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-09-18T22:59:27.667162Z","caller":"traceutil/trace.go:171","msg":"trace[716217412] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:2352; }","duration":"189.717485ms","start":"2026-09-18T22:59:27.477417Z","end":"2026-09-18T22:59:27.667134Z","steps":["trace[716217412] 'count revisions from in-memory index tree'  (duration: 189.303521ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:34.083921Z","caller":"traceutil/trace.go:171","msg":"trace[561548430] transaction","detail":"{read_only:false; response_revision:2391; number_of_response:1; }","duration":"123.583123ms","start":"2026-09-18T22:59:33.960272Z","end":"2026-09-18T22:59:34.083855Z","steps":["trace[561548430] 'process raft request'  (duration: 76.888891ms)","trace[561548430] 'compare'  (duration: 46.54305ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:59:35.444994Z","caller":"traceutil/trace.go:171","msg":"trace[1839325001] transaction","detail":"{read_only:false; response_revision:2399; number_of_response:1; }","duration":"151.398395ms","start":"2026-09-18T22:59:35.293511Z","end":"2026-09-18T22:59:35.44491Z","steps":["trace[1839325001] 'process raft request'  (duration: 72.358875ms)","trace[1839325001] 'compare'  (duration: 78.611475ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T22:59:35.445584Z","caller":"traceutil/trace.go:171","msg":"trace[1824191967] transaction","detail":"{read_only:false; response_revision:2400; number_of_response:1; }","duration":"151.023441ms","start":"2026-09-18T22:59:35.294531Z","end":"2026-09-18T22:59:35.445555Z","steps":["trace[1824191967] 'process raft request'  (duration: 150.301424ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T22:59:50.585884Z","caller":"traceutil/trace.go:171","msg":"trace[51563418] linearizableReadLoop","detail":"{readStateIndex:2668; appliedIndex:2667; }","duration":"186.623612ms","start":"2026-09-18T22:59:50.399191Z","end":"2026-09-18T22:59:50.585814Z","steps":["trace[51563418] 'read index received'  (duration: 179.274792ms)","trace[51563418] 'applied index is now lower than readState.Index'  (duration: 7.34286ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T22:59:50.586203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.981276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"}
{"level":"info","ts":"2026-09-18T22:59:50.586277Z","caller":"traceutil/trace.go:171","msg":"trace[1335719999] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2567; }","duration":"187.120617ms","start":"2026-09-18T22:59:50.399139Z","end":"2026-09-18T22:59:50.58626Z","steps":["trace[1335719999] 'agreement among raft nodes before linearized reading'  (duration: 186.832375ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:00:15.730745Z","caller":"traceutil/trace.go:171","msg":"trace[404122910] transaction","detail":"{read_only:false; response_revision:2709; number_of_response:1; }","duration":"103.607427ms","start":"2026-09-18T23:00:15.627091Z","end":"2026-09-18T23:00:15.730698Z","steps":["trace[404122910] 'process raft request'  (duration: 103.175565ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:00:26.625Z","caller":"traceutil/trace.go:171","msg":"trace[1513853177] transaction","detail":"{read_only:false; response_revision:2768; number_of_response:1; }","duration":"129.661246ms","start":"2026-09-18T23:00:26.49531Z","end":"2026-09-18T23:00:26.624971Z","steps":["trace[1513853177] 'process raft request'  (duration: 129.474117ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:10.807833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.752065ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14256884277086084732 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/monitoring/kube-prometheus-stack-admission-patch.18d68ccc376e779e\" mod_revision:0 > success:<request_put:<key:\"/registry/events/monitoring/kube-prometheus-stack-admission-patch.18d68ccc376e779e\" value_size:608 lease:5033512240231307223 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-09-18T23:05:10.808002Z","caller":"traceutil/trace.go:171","msg":"trace[1267671204] transaction","detail":"{read_only:false; response_revision:4863; number_of_response:1; }","duration":"105.677086ms","start":"2026-09-18T23:05:10.70231Z","end":"2026-09-18T23:05:10.807988Z","steps":["trace[1267671204] 'process raft request'  (duration: 105.606964ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:10.808085Z","caller":"traceutil/trace.go:171","msg":"trace[263147099] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"146.568721ms","start":"2026-09-18T23:05:10.661456Z","end":"2026-09-18T23:05:10.808025Z","steps":["trace[263147099] 'compare'  (duration: 139.640213ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:10.808533Z","caller":"traceutil/trace.go:171","msg":"trace[2029521289] linearizableReadLoop","detail":"{readStateIndex:5053; appliedIndex:5052; }","duration":"138.975403ms","start":"2026-09-18T23:05:10.669536Z","end":"2026-09-18T23:05:10.808512Z","steps":["trace[2029521289] 'read index received'  (duration: 39.741µs)","trace[2029521289] 'applied index is now lower than readState.Index'  (duration: 138.932952ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T23:05:10.808775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.217457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1261"}
{"level":"info","ts":"2026-09-18T23:05:10.808826Z","caller":"traceutil/trace.go:171","msg":"trace[604282027] range","detail":"{range_begin:/registry/serviceaccounts/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4863; }","duration":"139.313508ms","start":"2026-09-18T23:05:10.669496Z","end":"2026-09-18T23:05:10.80881Z","steps":["trace[604282027] 'agreement among raft nodes before linearized reading'  (duration: 139.140195ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:11.829227Z","caller":"traceutil/trace.go:171","msg":"trace[240819099] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4913; }","duration":"102.099973ms","start":"2026-09-18T23:05:11.727102Z","end":"2026-09-18T23:05:11.829202Z","steps":["trace[240819099] 'compare'  (duration: 77.378063ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:21.343797Z","caller":"traceutil/trace.go:171","msg":"trace[1959923471] linearizableReadLoop","detail":"{readStateIndex:5277; appliedIndex:5276; }","duration":"344.044647ms","start":"2026-09-18T23:05:20.999635Z","end":"2026-09-18T23:05:21.343679Z","steps":["trace[1959923471] 'read index received'  (duration: 343.919185ms)","trace[1959923471] 'applied index is now lower than readState.Index'  (duration: 124.532µs)"],"step_count":2}
{"level":"info","ts":"2026-09-18T23:05:21.343908Z","caller":"traceutil/trace.go:171","msg":"trace[429925480] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"363.280399ms","start":"2026-09-18T23:05:20.980616Z","end":"2026-09-18T23:05:21.343897Z","steps":["trace[429925480] 'process raft request'  (duration: 362.897293ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:21.344036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:20.980598Z","time spent":"363.334981ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5005 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-18T23:05:21.344243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.610237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-09-18T23:05:21.34428Z","caller":"traceutil/trace.go:171","msg":"trace[1831979159] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5079; }","duration":"344.674898ms","start":"2026-09-18T23:05:20.999594Z","end":"2026-09-18T23:05:21.344269Z","steps":["trace[1831979159] 'agreement among raft nodes before linearized reading'  (duration: 344.552306ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:21.344305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:20.999577Z","time spent":"344.722719ms","remote":"127.0.0.1:36448","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3529,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "}
{"level":"info","ts":"2026-09-18T23:05:21.359028Z","caller":"traceutil/trace.go:171","msg":"trace[809516799] transaction","detail":"{read_only:false; response_revision:5080; number_of_response:1; }","duration":"284.779268ms","start":"2026-09-18T23:05:21.074227Z","end":"2026-09-18T23:05:21.359006Z","steps":["trace[809516799] 'process raft request'  (duration: 284.470612ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:21.359284Z","caller":"traceutil/trace.go:171","msg":"trace[1438899553] transaction","detail":"{read_only:false; response_revision:5081; number_of_response:1; }","duration":"272.126096ms","start":"2026-09-18T23:05:21.087134Z","end":"2026-09-18T23:05:21.35926Z","steps":["trace[1438899553] 'process raft request'  (duration: 271.698979ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:21.359326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.41537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:1 size:897"}
{"level":"info","ts":"2026-09-18T23:05:21.359395Z","caller":"traceutil/trace.go:171","msg":"trace[1672238631] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:1; response_revision:5081; }","duration":"333.483742ms","start":"2026-09-18T23:05:21.02589Z","end":"2026-09-18T23:05:21.359374Z","steps":["trace[1672238631] 'agreement among raft nodes before linearized reading'  (duration: 333.286928ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:21.359446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:21.02583Z","time spent":"333.604544ms","remote":"127.0.0.1:36538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":920,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "}
{"level":"info","ts":"2026-09-18T23:05:21.734407Z","caller":"traceutil/trace.go:171","msg":"trace[635933998] transaction","detail":"{read_only:false; response_revision:5085; number_of_response:1; }","duration":"147.769659ms","start":"2026-09-18T23:05:21.586596Z","end":"2026-09-18T23:05:21.734365Z","steps":["trace[635933998] 'process raft request'  (duration: 71.863391ms)","trace[635933998] 'compare'  (duration: 75.697175ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T23:05:21.879052Z","caller":"traceutil/trace.go:171","msg":"trace[1442266894] transaction","detail":"{read_only:false; response_revision:5087; number_of_response:1; }","duration":"126.586914ms","start":"2026-09-18T23:05:21.75243Z","end":"2026-09-18T23:05:21.879017Z","steps":["trace[1442266894] 'process raft request'  (duration: 91.702971ms)","trace[1442266894] 'compare'  (duration: 34.68917ms)"],"step_count":2}
{"level":"warn","ts":"2026-09-18T23:05:21.879186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.714383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"}
{"level":"info","ts":"2026-09-18T23:05:21.879252Z","caller":"traceutil/trace.go:171","msg":"trace[1910295437] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:5087; }","duration":"103.813024ms","start":"2026-09-18T23:05:21.775424Z","end":"2026-09-18T23:05:21.879237Z","steps":["trace[1910295437] 'agreement among raft nodes before linearized reading'  (duration: 103.5971ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:21.879569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.799161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0debccad-c1bf-41f5-9032-984380258a1c\" ","response":"range_response_count:1 size:3645"}
{"level":"info","ts":"2026-09-18T23:05:21.879633Z","caller":"traceutil/trace.go:171","msg":"trace[198504501] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0debccad-c1bf-41f5-9032-984380258a1c; range_end:; response_count:1; response_revision:5087; }","duration":"122.868692ms","start":"2026-09-18T23:05:21.756748Z","end":"2026-09-18T23:05:21.879617Z","steps":["trace[198504501] 'agreement among raft nodes before linearized reading'  (duration: 122.689789ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:33.747569Z","caller":"traceutil/trace.go:171","msg":"trace[1626452147] linearizableReadLoop","detail":"{readStateIndex:5442; appliedIndex:5441; }","duration":"348.237276ms","start":"2026-09-18T23:05:33.399305Z","end":"2026-09-18T23:05:33.747542Z","steps":["trace[1626452147] 'read index received'  (duration: 348.050222ms)","trace[1626452147] 'applied index is now lower than readState.Index'  (duration: 186.163µs)"],"step_count":2}
{"level":"info","ts":"2026-09-18T23:05:33.747657Z","caller":"traceutil/trace.go:171","msg":"trace[1312996639] transaction","detail":"{read_only:false; response_revision:5239; number_of_response:1; }","duration":"349.518557ms","start":"2026-09-18T23:05:33.398107Z","end":"2026-09-18T23:05:33.747626Z","steps":["trace[1312996639] 'process raft request'  (duration: 349.276223ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:33.747823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.510971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"}
{"level":"warn","ts":"2026-09-18T23:05:33.747854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:33.398076Z","time spent":"349.645258ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:5224 > 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-09-18T23:05:33.747893Z","caller":"traceutil/trace.go:171","msg":"trace[838266838] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:5239; }","duration":"348.610432ms","start":"2026-09-18T23:05:33.399271Z","end":"2026-09-18T23:05:33.747881Z","steps":["trace[838266838] 'agreement among raft nodes before linearized reading'  (duration: 348.432219ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:33.747921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:33.399258Z","time spent":"348.656513ms","remote":"127.0.0.1:35460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5706,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "}
{"level":"warn","ts":"2026-09-18T23:05:33.879246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.274554ms","expected-duration":"100ms","prefix":"","request":"header:<ID:14256884277086085639 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5225 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-09-18T23:05:33.879578Z","caller":"traceutil/trace.go:171","msg":"trace[254163319] transaction","detail":"{read_only:false; response_revision:5240; number_of_response:1; }","duration":"478.069366ms","start":"2026-09-18T23:05:33.401485Z","end":"2026-09-18T23:05:33.879554Z","steps":["trace[254163319] 'process raft request'  (duration: 357.308514ms)","trace[254163319] 'compare'  (duration: 120.137832ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T23:05:33.879671Z","caller":"traceutil/trace.go:171","msg":"trace[177617027] transaction","detail":"{read_only:false; response_revision:5241; number_of_response:1; }","duration":"476.41832ms","start":"2026-09-18T23:05:33.403219Z","end":"2026-09-18T23:05:33.879637Z","steps":["trace[177617027] 'process raft request'  (duration: 476.124925ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:33.879847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:33.403197Z","time spent":"476.545672ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:5226 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:455 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"warn","ts":"2026-09-18T23:05:33.879863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:33.401474Z","time spent":"478.151919ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/plndr-cp-lock\" mod_revision:5225 > success:<request_put:<key:\"/registry/leases/kube-system/plndr-cp-lock\" value_size:369 >> failure:<request_range:<key:\"/registry/leases/kube-system/plndr-cp-lock\" > >"}
{"level":"warn","ts":"2026-09-18T23:05:33.880022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.678229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"}
{"level":"info","ts":"2026-09-18T23:05:33.880149Z","caller":"traceutil/trace.go:171","msg":"trace[1985956723] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5241; }","duration":"243.873213ms","start":"2026-09-18T23:05:33.636253Z","end":"2026-09-18T23:05:33.880126Z","steps":["trace[1985956723] 'agreement among raft nodes before linearized reading'  (duration: 243.447846ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:33.880329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.404153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"}
{"level":"info","ts":"2026-09-18T23:05:33.879646Z","caller":"traceutil/trace.go:171","msg":"trace[110155404] linearizableReadLoop","detail":"{readStateIndex:5444; appliedIndex:5442; }","duration":"131.962446ms","start":"2026-09-18T23:05:33.747654Z","end":"2026-09-18T23:05:33.879616Z","steps":["trace[110155404] 'read index received'  (duration: 11.123813ms)","trace[110155404] 'applied index is now lower than readState.Index'  (duration: 120.836843ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T23:05:33.880512Z","caller":"traceutil/trace.go:171","msg":"trace[1281760017] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5241; }","duration":"330.481184ms","start":"2026-09-18T23:05:33.549904Z","end":"2026-09-18T23:05:33.880385Z","steps":["trace[1281760017] 'agreement among raft nodes before linearized reading'  (duration: 330.186259ms)"],"step_count":1}
{"level":"warn","ts":"2026-09-18T23:05:33.88063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T23:05:33.549809Z","time spent":"330.80646ms","remote":"127.0.0.1:36586","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-09-18T23:05:34.139143Z","caller":"traceutil/trace.go:171","msg":"trace[1782025214] transaction","detail":"{read_only:false; response_revision:5248; number_of_response:1; }","duration":"126.784138ms","start":"2026-09-18T23:05:34.012337Z","end":"2026-09-18T23:05:34.139121Z","steps":["trace[1782025214] 'process raft request'  (duration: 105.228924ms)","trace[1782025214] 'compare'  (duration: 20.927643ms)"],"step_count":2}
{"level":"info","ts":"2026-09-18T23:05:34.139373Z","caller":"traceutil/trace.go:171","msg":"trace[690889027] transaction","detail":"{read_only:false; response_revision:5249; number_of_response:1; }","duration":"126.780628ms","start":"2026-09-18T23:05:34.012558Z","end":"2026-09-18T23:05:34.139338Z","steps":["trace[690889027] 'process raft request'  (duration: 126.076427ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:34.139671Z","caller":"traceutil/trace.go:171","msg":"trace[931627626] transaction","detail":"{read_only:false; response_revision:5250; number_of_response:1; }","duration":"126.754348ms","start":"2026-09-18T23:05:34.012872Z","end":"2026-09-18T23:05:34.139626Z","steps":["trace[931627626] 'process raft request'  (duration: 125.818532ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:05:41.245601Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2844}
{"level":"info","ts":"2026-09-18T23:05:41.430815Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2844,"took":"183.61554ms","hash":3508546480,"current-db-size-bytes":52465664,"current-db-size":"52 MB","current-db-size-in-use-bytes":27377664,"current-db-size-in-use":"27 MB"}
{"level":"info","ts":"2026-09-18T23:05:41.430877Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3508546480,"revision":2844,"compact-revision":-1}
{"level":"info","ts":"2026-09-18T23:06:26.426799Z","caller":"traceutil/trace.go:171","msg":"trace[1616988916] transaction","detail":"{read_only:false; response_revision:5694; number_of_response:1; }","duration":"126.345217ms","start":"2026-09-18T23:06:26.300422Z","end":"2026-09-18T23:06:26.426768Z","steps":["trace[1616988916] 'process raft request'  (duration: 126.077313ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:06:26.426974Z","caller":"traceutil/trace.go:171","msg":"trace[2103871437] transaction","detail":"{read_only:false; response_revision:5695; number_of_response:1; }","duration":"121.223998ms","start":"2026-09-18T23:06:26.305721Z","end":"2026-09-18T23:06:26.426945Z","steps":["trace[2103871437] 'process raft request'  (duration: 121.015345ms)"],"step_count":1}
{"level":"info","ts":"2026-09-18T23:10:41.255752Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5302}
{"level":"info","ts":"2026-09-18T23:10:41.386653Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5302,"took":"129.511177ms","hash":1565152689,"current-db-size-bytes":52465664,"current-db-size":"52 MB","current-db-size-in-use-bytes":18698240,"current-db-size-in-use":"19 MB"}
{"level":"info","ts":"2026-09-18T23:10:41.386737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1565152689,"revision":5302,"compact-revision":2844}
{"level":"info","ts":"2026-09-18T23:11:08.963214Z","caller":"traceutil/trace.go:171","msg":"trace[2062159114] transaction","detail":"{read_only:false; response_revision:7514; number_of_response:1; }","duration":"118.829641ms","start":"2026-09-18T23:11:08.844365Z","end":"2026-09-18T23:11:08.963195Z","steps":["trace[2062159114] 'process raft request'  (duration: 118.690367ms)"],"step_count":1}