{"level":"warn","ts":"2026-09-22T01:41:44.477517Z","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-22T01:41:44.477585Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.3: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.3:2380","--initial-cluster=instance=https://162.253.55.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.3: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-22T01:41:44.477646Z","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-22T01:41:44.477655Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.3:2380"]} {"level":"info","ts":"2026-09-22T01:41:44.477669Z","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-22T01:41:44.478211Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.3:2379"]} {"level":"info","ts":"2026-09-22T01:41:44.478275Z","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.3:2380"],"listen-peer-urls":["https://162.253.55.3:2380"],"advertise-client-urls":["https://162.253.55.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.3: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-22T01:41:44.487514Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.076798ms"} {"level":"info","ts":"2026-09-22T01:41:44.500821Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a99b527d1e65fdd9","cluster-id":"9bd8b4a41eaf5d40"} {"level":"info","ts":"2026-09-22T01:41:44.500893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T01:41:44.500912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became follower at term 0"} {"level":"info","ts":"2026-09-22T01:41:44.500919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a99b527d1e65fdd9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T01:41:44.500925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became follower at term 1"} {"level":"info","ts":"2026-09-22T01:41:44.500956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 switched to configuration voters=(12221452711134363097)"} {"level":"warn","ts":"2026-09-22T01:41:44.506882Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T01:41:44.508231Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T01:41:44.50951Z","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-22T01:41:44.511329Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a99b527d1e65fdd9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T01:41:44.513272Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a99b527d1e65fdd9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T01:41:44.513308Z","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-22T01:41:44.513454Z","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-22T01:41:44.513471Z","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-22T01:41:44.514157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 switched to configuration voters=(12221452711134363097)"} {"level":"info","ts":"2026-09-22T01:41:44.514253Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bd8b4a41eaf5d40","local-member-id":"a99b527d1e65fdd9","added-peer-id":"a99b527d1e65fdd9","added-peer-peer-urls":["https://162.253.55.3:2380"]} {"level":"info","ts":"2026-09-22T01:41:44.515266Z","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-22T01:41:44.515374Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.3:2380"} {"level":"info","ts":"2026-09-22T01:41:44.515402Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.3:2380"} {"level":"info","ts":"2026-09-22T01:41:44.515693Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a99b527d1e65fdd9","initial-advertise-peer-urls":["https://162.253.55.3:2380"],"listen-peer-urls":["https://162.253.55.3:2380"],"advertise-client-urls":["https://162.253.55.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T01:41:44.515726Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T01:41:44.701102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T01:41:44.701179Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T01:41:44.701207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 received MsgPreVoteResp from a99b527d1e65fdd9 at term 1"} {"level":"info","ts":"2026-09-22T01:41:44.701232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became candidate at term 2"} {"level":"info","ts":"2026-09-22T01:41:44.701247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 received MsgVoteResp from a99b527d1e65fdd9 at term 2"} {"level":"info","ts":"2026-09-22T01:41:44.701266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a99b527d1e65fdd9 became leader at term 2"} {"level":"info","ts":"2026-09-22T01:41:44.701284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a99b527d1e65fdd9 elected leader a99b527d1e65fdd9 at term 2"} {"level":"info","ts":"2026-09-22T01:41:44.703193Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a99b527d1e65fdd9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.3:2379]}","request-path":"/0/members/a99b527d1e65fdd9/attributes","cluster-id":"9bd8b4a41eaf5d40","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T01:41:44.703296Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:41:44.703441Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T01:41:44.70358Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:41:44.703696Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T01:41:44.703717Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T01:41:44.704906Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bd8b4a41eaf5d40","local-member-id":"a99b527d1e65fdd9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:41:44.70501Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:41:44.705164Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T01:41:44.70647Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T01:41:44.706535Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.3:2379"} {"level":"warn","ts":"2026-09-22T01:41:48.716808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.107888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:41:48.716937Z","caller":"traceutil/trace.go:171","msg":"trace[922917572] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"552.783966ms","start":"2026-09-22T01:41:48.164136Z","end":"2026-09-22T01:41:48.71692Z","steps":["trace[922917572] 'process raft request' (duration: 164.103511ms)","trace[922917572] 'compare' (duration: 387.983203ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:41:48.717096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:41:48.164122Z","time spent":"552.946343ms","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T01:41:48.938479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.541057ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:41:48.938646Z","caller":"traceutil/trace.go:171","msg":"trace[696138970] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"657.200052ms","start":"2026-09-22T01:41:48.281405Z","end":"2026-09-22T01:41:48.938605Z","steps":["trace[696138970] 'process raft request' (duration: 549.473076ms)","trace[696138970] 'compare' (duration: 107.414921ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:41:48.938824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:41:48.28137Z","time spent":"657.371449ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T01:41:48.938961Z","caller":"traceutil/trace.go:171","msg":"trace[530487419] linearizableReadLoop","detail":"{readStateIndex:205; appliedIndex:204; }","duration":"524.338321ms","start":"2026-09-22T01:41:48.414561Z","end":"2026-09-22T01:41:48.938899Z","steps":["trace[530487419] 'read index received' (duration: 416.326082ms)","trace[530487419] 'applied index is now lower than readState.Index' (duration: 108.009009ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:41:48.939143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.543211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:41:48.939376Z","caller":"traceutil/trace.go:171","msg":"trace[1913704890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:199; }","duration":"524.832073ms","start":"2026-09-22T01:41:48.414514Z","end":"2026-09-22T01:41:48.939347Z","steps":["trace[1913704890] 'agreement among raft nodes before linearized reading' (duration: 524.520699ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:41:48.93989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:41:48.414496Z","time spent":"525.263553ms","remote":"127.0.0.1:59054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-22T01:42:26.49916Z","caller":"traceutil/trace.go:171","msg":"trace[2063692159] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"143.163702ms","start":"2026-09-22T01:42:26.355973Z","end":"2026-09-22T01:42:26.499137Z","steps":["trace[2063692159] 'process raft request' (duration: 143.045807ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.614287Z","caller":"traceutil/trace.go:171","msg":"trace[1206327937] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"169.451591ms","start":"2026-09-22T01:42:30.444796Z","end":"2026-09-22T01:42:30.614247Z","steps":["trace[1206327937] 'process raft request' (duration: 169.237381ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.61446Z","caller":"traceutil/trace.go:171","msg":"trace[1517806528] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"154.291995ms","start":"2026-09-22T01:42:30.460151Z","end":"2026-09-22T01:42:30.614443Z","steps":["trace[1517806528] 'process raft request' (duration: 154.069865ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.614558Z","caller":"traceutil/trace.go:171","msg":"trace[92089833] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"129.844377ms","start":"2026-09-22T01:42:30.484697Z","end":"2026-09-22T01:42:30.614541Z","steps":["trace[92089833] 'process raft request' (duration: 129.801125ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.614612Z","caller":"traceutil/trace.go:171","msg":"trace[1741518833] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"154.418131ms","start":"2026-09-22T01:42:30.460186Z","end":"2026-09-22T01:42:30.614604Z","steps":["trace[1741518833] 'process raft request' (duration: 154.073875ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.614578Z","caller":"traceutil/trace.go:171","msg":"trace[1238833800] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"153.33328ms","start":"2026-09-22T01:42:30.461234Z","end":"2026-09-22T01:42:30.614567Z","steps":["trace[1238833800] 'process raft request' (duration: 153.133211ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.6146Z","caller":"traceutil/trace.go:171","msg":"trace[791066267] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"164.06787ms","start":"2026-09-22T01:42:30.450526Z","end":"2026-09-22T01:42:30.614594Z","steps":["trace[791066267] 'process raft request' (duration: 163.616409ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.61463Z","caller":"traceutil/trace.go:171","msg":"trace[389264778] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"154.524546ms","start":"2026-09-22T01:42:30.460089Z","end":"2026-09-22T01:42:30.614614Z","steps":["trace[389264778] 'process raft request' (duration: 154.095446ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.614772Z","caller":"traceutil/trace.go:171","msg":"trace[1854874771] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"149.239159ms","start":"2026-09-22T01:42:30.465528Z","end":"2026-09-22T01:42:30.614767Z","steps":["trace[1854874771] 'process raft request' (duration: 148.877882ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.614848Z","caller":"traceutil/trace.go:171","msg":"trace[134162219] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"143.812457ms","start":"2026-09-22T01:42:30.471032Z","end":"2026-09-22T01:42:30.614844Z","steps":["trace[134162219] 'process raft request' (duration: 143.416558ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.626756Z","caller":"traceutil/trace.go:171","msg":"trace[1254284394] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:568; }","duration":"113.751877ms","start":"2026-09-22T01:42:30.512994Z","end":"2026-09-22T01:42:30.626746Z","steps":["trace[1254284394] 'read index received' (duration: 101.119199ms)","trace[1254284394] 'applied index is now lower than readState.Index' (duration: 12.632068ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:42:30.626821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.81513ms","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-09-22T01:42:30.626859Z","caller":"traceutil/trace.go:171","msg":"trace[1769774247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:555; }","duration":"113.882973ms","start":"2026-09-22T01:42:30.512971Z","end":"2026-09-22T01:42:30.626854Z","steps":["trace[1769774247] 'agreement among raft nodes before linearized reading' (duration: 113.80702ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.627017Z","caller":"traceutil/trace.go:171","msg":"trace[1503693492] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"111.180747ms","start":"2026-09-22T01:42:30.515831Z","end":"2026-09-22T01:42:30.627012Z","steps":["trace[1503693492] 'process raft request' (duration: 110.860852ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.627048Z","caller":"traceutil/trace.go:171","msg":"trace[731043658] transaction","detail":"{read_only:false; number_of_response:1; response_revision:554; }","duration":"117.67615ms","start":"2026-09-22T01:42:30.509347Z","end":"2026-09-22T01:42:30.627023Z","steps":["trace[731043658] 'process raft request' (duration: 117.313053ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.627201Z","caller":"traceutil/trace.go:171","msg":"trace[885918777] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"117.853088ms","start":"2026-09-22T01:42:30.509328Z","end":"2026-09-22T01:42:30.627181Z","steps":["trace[885918777] 'process raft request' (duration: 117.299333ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:30.627222Z","caller":"traceutil/trace.go:171","msg":"trace[739152884] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"117.88498ms","start":"2026-09-22T01:42:30.509328Z","end":"2026-09-22T01:42:30.627213Z","steps":["trace[739152884] 'process raft request' (duration: 117.229399ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:36.805917Z","caller":"traceutil/trace.go:171","msg":"trace[146553141] linearizableReadLoop","detail":"{readStateIndex:679; appliedIndex:678; }","duration":"119.563384ms","start":"2026-09-22T01:42:36.686337Z","end":"2026-09-22T01:42:36.8059Z","steps":["trace[146553141] 'read index received' (duration: 119.48371ms)","trace[146553141] 'applied index is now lower than readState.Index' (duration: 79.004µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:42:36.806062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.715241ms","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-09-22T01:42:36.80608Z","caller":"traceutil/trace.go:171","msg":"trace[1349476172] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:648; }","duration":"119.776004ms","start":"2026-09-22T01:42:36.686298Z","end":"2026-09-22T01:42:36.806074Z","steps":["trace[1349476172] 'agreement among raft nodes before linearized reading' (duration: 119.667149ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:36.80626Z","caller":"traceutil/trace.go:171","msg":"trace[1157300087] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"126.630814ms","start":"2026-09-22T01:42:36.679623Z","end":"2026-09-22T01:42:36.806254Z","steps":["trace[1157300087] 'process raft request' (duration: 126.177773ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:37.304002Z","caller":"traceutil/trace.go:171","msg":"trace[1092793629] linearizableReadLoop","detail":"{readStateIndex:681; appliedIndex:680; }","duration":"425.821523ms","start":"2026-09-22T01:42:36.878155Z","end":"2026-09-22T01:42:37.303976Z","steps":["trace[1092793629] 'read index received' (duration: 424.881929ms)","trace[1092793629] 'applied index is now lower than readState.Index' (duration: 938.364µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:42:37.304063Z","caller":"traceutil/trace.go:171","msg":"trace[1157576658] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"463.518163ms","start":"2026-09-22T01:42:36.840516Z","end":"2026-09-22T01:42:37.304035Z","steps":["trace[1157576658] 'process raft request' (duration: 462.866013ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:42:37.30413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.954489ms","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-22T01:42:37.304162Z","caller":"traceutil/trace.go:171","msg":"trace[959926314] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"426.029772ms","start":"2026-09-22T01:42:36.878121Z","end":"2026-09-22T01:42:37.304151Z","steps":["trace[959926314] 'agreement among raft nodes before linearized reading' (duration: 425.948868ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:42:37.304213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:42:36.878103Z","time spent":"426.099175ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-22T01:42:37.304327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:42:36.840483Z","time spent":"463.637588ms","remote":"127.0.0.1:59154","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:42:37.45284Z","caller":"traceutil/trace.go:171","msg":"trace[1850586936] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"143.638131ms","start":"2026-09-22T01:42:37.309171Z","end":"2026-09-22T01:42:37.452809Z","steps":["trace[1850586936] 'process raft request' (duration: 89.847338ms)","trace[1850586936] 'compare' (duration: 53.334432ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:42:38.217191Z","caller":"traceutil/trace.go:171","msg":"trace[989814671] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"153.528396ms","start":"2026-09-22T01:42:38.063638Z","end":"2026-09-22T01:42:38.217166Z","steps":["trace[989814671] 'read index received' (duration: 152.673306ms)","trace[989814671] 'applied index is now lower than readState.Index' (duration: 853.76µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:42:38.217253Z","caller":"traceutil/trace.go:171","msg":"trace[478845436] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"293.091989ms","start":"2026-09-22T01:42:37.924129Z","end":"2026-09-22T01:42:38.217221Z","steps":["trace[478845436] 'process raft request' (duration: 292.416597ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:42:38.217358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.709565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-09-22T01:42:38.217406Z","caller":"traceutil/trace.go:171","msg":"trace[1865320165] range","detail":"{range_begin:/registry/masterleases/162.253.55.3; range_end:; response_count:1; response_revision:659; }","duration":"153.793469ms","start":"2026-09-22T01:42:38.063598Z","end":"2026-09-22T01:42:38.217391Z","steps":["trace[1865320165] 'agreement among raft nodes before linearized reading' (duration: 153.690134ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:42:38.217453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.042904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-22T01:42:38.21822Z","caller":"traceutil/trace.go:171","msg":"trace[68577090] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:659; }","duration":"113.841031ms","start":"2026-09-22T01:42:38.104353Z","end":"2026-09-22T01:42:38.218194Z","steps":["trace[68577090] 'agreement among raft nodes before linearized reading' (duration: 112.979461ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:45.22618Z","caller":"traceutil/trace.go:171","msg":"trace[1243721288] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"115.242392ms","start":"2026-09-22T01:42:45.110914Z","end":"2026-09-22T01:42:45.226157Z","steps":["trace[1243721288] 'process raft request' (duration: 115.108833ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:42:53.728907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.391041ms","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-22T01:42:53.729181Z","caller":"traceutil/trace.go:171","msg":"trace[233068467] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:816; }","duration":"192.675951ms","start":"2026-09-22T01:42:53.536449Z","end":"2026-09-22T01:42:53.729125Z","steps":["trace[233068467] 'range keys from in-memory index tree' (duration: 192.193502ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:42:53.771624Z","caller":"traceutil/trace.go:171","msg":"trace[203703338] linearizableReadLoop","detail":"{readStateIndex:853; appliedIndex:852; }","duration":"136.550444ms","start":"2026-09-22T01:42:53.635052Z","end":"2026-09-22T01:42:53.771602Z","steps":["trace[203703338] 'read index received' (duration: 86.659586ms)","trace[203703338] 'applied index is now lower than readState.Index' (duration: 49.889738ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:42:53.77177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.689424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:42:53.771855Z","caller":"traceutil/trace.go:171","msg":"trace[1267100544] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:816; }","duration":"136.831093ms","start":"2026-09-22T01:42:53.635003Z","end":"2026-09-22T01:42:53.771834Z","steps":["trace[1267100544] 'agreement among raft nodes before linearized reading' (duration: 136.668794ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:43:17.256729Z","caller":"traceutil/trace.go:171","msg":"trace[378467071] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"139.831704ms","start":"2026-09-22T01:43:17.116861Z","end":"2026-09-22T01:43:17.256693Z","steps":["trace[378467071] 'process raft request' (duration: 128.919058ms)","trace[378467071] 'compare' (duration: 10.780165ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:43:46.695907Z","caller":"traceutil/trace.go:171","msg":"trace[1447172390] linearizableReadLoop","detail":"{readStateIndex:1505; appliedIndex:1504; }","duration":"102.423303ms","start":"2026-09-22T01:43:46.59346Z","end":"2026-09-22T01:43:46.695883Z","steps":["trace[1447172390] 'read index received' (duration: 102.12581ms)","trace[1447172390] 'applied index is now lower than readState.Index' (duration: 296.783µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:43:46.696135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.656596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend\" ","response":"range_response_count:1 size:1041"} {"level":"info","ts":"2026-09-22T01:43:46.696194Z","caller":"traceutil/trace.go:171","msg":"trace[2140922152] range","detail":"{range_begin:/registry/serviceaccounts/ingress-nginx/ingress-nginx-backend; range_end:; response_count:1; response_revision:1453; }","duration":"102.751337ms","start":"2026-09-22T01:43:46.593425Z","end":"2026-09-22T01:43:46.696177Z","steps":["trace[2140922152] 'agreement among raft nodes before linearized reading' (duration: 102.586955ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:43:46.695967Z","caller":"traceutil/trace.go:171","msg":"trace[1804716632] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"105.616921ms","start":"2026-09-22T01:43:46.590323Z","end":"2026-09-22T01:43:46.69594Z","steps":["trace[1804716632] 'process raft request' (duration: 105.379768ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:43:48.418986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.502401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T01:43:48.419084Z","caller":"traceutil/trace.go:171","msg":"trace[1887054384] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1480; }","duration":"128.662314ms","start":"2026-09-22T01:43:48.290403Z","end":"2026-09-22T01:43:48.419065Z","steps":["trace[1887054384] 'count revisions from in-memory index tree' (duration: 128.36755ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:18.078369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.13996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-22T01:44:18.078469Z","caller":"traceutil/trace.go:171","msg":"trace[2134457266] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1922; }","duration":"105.284982ms","start":"2026-09-22T01:44:17.973163Z","end":"2026-09-22T01:44:18.078448Z","steps":["trace[2134457266] 'range keys from in-memory index tree' (duration: 104.879805ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:18.422224Z","caller":"traceutil/trace.go:171","msg":"trace[310410710] transaction","detail":"{read_only:false; response_revision:1925; number_of_response:1; }","duration":"213.787037ms","start":"2026-09-22T01:44:18.208413Z","end":"2026-09-22T01:44:18.4222Z","steps":["trace[310410710] 'process raft request' (duration: 213.639064ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:18.432111Z","caller":"traceutil/trace.go:171","msg":"trace[1781933204] linearizableReadLoop","detail":"{readStateIndex:2006; appliedIndex:2004; }","duration":"195.5887ms","start":"2026-09-22T01:44:18.236494Z","end":"2026-09-22T01:44:18.432083Z","steps":["trace[1781933204] 'read index received' (duration: 185.558744ms)","trace[1781933204] 'applied index is now lower than readState.Index' (duration: 10.028926ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:44:18.43216Z","caller":"traceutil/trace.go:171","msg":"trace[1127758396] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"202.019588ms","start":"2026-09-22T01:44:18.23011Z","end":"2026-09-22T01:44:18.43213Z","steps":["trace[1127758396] 'process raft request' (duration: 201.845375ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:18.432387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.878955ms","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-09-22T01:44:18.432604Z","caller":"traceutil/trace.go:171","msg":"trace[1831730149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1926; }","duration":"196.14447ms","start":"2026-09-22T01:44:18.236443Z","end":"2026-09-22T01:44:18.432588Z","steps":["trace[1831730149] 'agreement among raft nodes before linearized reading' (duration: 195.820134ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:24.625238Z","caller":"traceutil/trace.go:171","msg":"trace[387225909] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"124.084269ms","start":"2026-09-22T01:44:24.501087Z","end":"2026-09-22T01:44:24.625171Z","steps":["trace[387225909] 'process raft request' (duration: 118.209314ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:30.860366Z","caller":"traceutil/trace.go:171","msg":"trace[1503484633] linearizableReadLoop","detail":"{readStateIndex:2107; appliedIndex:2106; }","duration":"292.893715ms","start":"2026-09-22T01:44:30.567447Z","end":"2026-09-22T01:44:30.860341Z","steps":["trace[1503484633] 'read index received' (duration: 292.62082ms)","trace[1503484633] 'applied index is now lower than readState.Index' (duration: 271.395µs)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:44:30.860486Z","caller":"traceutil/trace.go:171","msg":"trace[508509369] transaction","detail":"{read_only:false; response_revision:2025; number_of_response:1; }","duration":"383.448601ms","start":"2026-09-22T01:44:30.477017Z","end":"2026-09-22T01:44:30.860466Z","steps":["trace[508509369] 'process raft request' (duration: 383.096534ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:30.860596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:30.47699Z","time spent":"383.523542ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:44:30.860715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.245532ms","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-22T01:44:30.860809Z","caller":"traceutil/trace.go:171","msg":"trace[1357875212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2025; }","duration":"293.387895ms","start":"2026-09-22T01:44:30.567399Z","end":"2026-09-22T01:44:30.860787Z","steps":["trace[1357875212] 'agreement among raft nodes before linearized reading' (duration: 293.087079ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:30.865598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.242535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:44:30.865673Z","caller":"traceutil/trace.go:171","msg":"trace[229101779] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2026; }","duration":"231.353607ms","start":"2026-09-22T01:44:30.634302Z","end":"2026-09-22T01:44:30.865656Z","steps":["trace[229101779] 'agreement among raft nodes before linearized reading' (duration: 231.193234ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:30.865969Z","caller":"traceutil/trace.go:171","msg":"trace[1909380722] transaction","detail":"{read_only:false; response_revision:2026; number_of_response:1; }","duration":"220.531094ms","start":"2026-09-22T01:44:30.645417Z","end":"2026-09-22T01:44:30.865948Z","steps":["trace[1909380722] 'process raft request' (duration: 219.954892ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:30.866159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.416329ms","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-09-22T01:44:30.86621Z","caller":"traceutil/trace.go:171","msg":"trace[211511631] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2026; }","duration":"215.50351ms","start":"2026-09-22T01:44:30.650697Z","end":"2026-09-22T01:44:30.8662Z","steps":["trace[211511631] 'agreement among raft nodes before linearized reading' (duration: 215.363087ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:52.154633Z","caller":"traceutil/trace.go:171","msg":"trace[889258438] transaction","detail":"{read_only:false; response_revision:2161; number_of_response:1; }","duration":"138.771187ms","start":"2026-09-22T01:44:52.015837Z","end":"2026-09-22T01:44:52.154608Z","steps":["trace[889258438] 'process raft request' (duration: 138.611273ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:52.480958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.15688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T01:44:52.481102Z","caller":"traceutil/trace.go:171","msg":"trace[506581146] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:2161; }","duration":"165.279983ms","start":"2026-09-22T01:44:52.315764Z","end":"2026-09-22T01:44:52.481044Z","steps":["trace[506581146] 'count revisions from in-memory index tree' (duration: 165.037286ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:53.255874Z","caller":"traceutil/trace.go:171","msg":"trace[1766147870] transaction","detail":"{read_only:false; response_revision:2162; number_of_response:1; }","duration":"311.291267ms","start":"2026-09-22T01:44:52.944561Z","end":"2026-09-22T01:44:53.255852Z","steps":["trace[1766147870] 'process raft request' (duration: 311.142814ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:53.256018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:52.944539Z","time spent":"311.40238ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:44:53.413183Z","caller":"traceutil/trace.go:171","msg":"trace[2027242729] transaction","detail":"{read_only:false; response_revision:2163; number_of_response:1; }","duration":"464.683517ms","start":"2026-09-22T01:44:52.948463Z","end":"2026-09-22T01:44:53.413147Z","steps":["trace[2027242729] 'process raft request' (duration: 366.022768ms)","trace[2027242729] 'compare' (duration: 98.322701ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:44:53.4133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:52.94844Z","time spent":"464.79911ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:44:53.487659Z","caller":"traceutil/trace.go:171","msg":"trace[149695064] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"158.812459ms","start":"2026-09-22T01:44:53.328824Z","end":"2026-09-22T01:44:53.487636Z","steps":["trace[149695064] 'process raft request' (duration: 158.690266ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:53.487657Z","caller":"traceutil/trace.go:171","msg":"trace[1185882719] linearizableReadLoop","detail":"{readStateIndex:2249; appliedIndex:2247; }","duration":"515.610998ms","start":"2026-09-22T01:44:52.972012Z","end":"2026-09-22T01:44:53.487623Z","steps":["trace[1185882719] 'read index received' (duration: 283.745487ms)","trace[1185882719] 'applied index is now lower than readState.Index' (duration: 231.860681ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:44:53.487935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.905166ms","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-22T01:44:53.487973Z","caller":"traceutil/trace.go:171","msg":"trace[429953096] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2164; }","duration":"516.003958ms","start":"2026-09-22T01:44:52.97196Z","end":"2026-09-22T01:44:53.487964Z","steps":["trace[429953096] 'agreement among raft nodes before linearized reading' (duration: 515.828874ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:53.488009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:52.971941Z","time spent":"516.057459ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-22T01:44:53.488204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.671187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-22T01:44:53.488232Z","caller":"traceutil/trace.go:171","msg":"trace[907771796] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2164; }","duration":"411.730828ms","start":"2026-09-22T01:44:53.076494Z","end":"2026-09-22T01:44:53.488225Z","steps":["trace[907771796] 'agreement among raft nodes before linearized reading' (duration: 411.630226ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:53.488254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.076478Z","time spent":"411.771359ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-09-22T01:44:53.488334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.846652ms","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-09-22T01:44:53.488455Z","caller":"traceutil/trace.go:171","msg":"trace[840492489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2164; }","duration":"503.002846ms","start":"2026-09-22T01:44:52.98543Z","end":"2026-09-22T01:44:53.488433Z","steps":["trace[840492489] 'agreement among raft nodes before linearized reading' (duration: 502.666228ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:53.488803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:52.985418Z","time spent":"503.368605ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-09-22T01:44:53.488604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.877588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-09-22T01:44:53.489173Z","caller":"traceutil/trace.go:171","msg":"trace[951669268] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2164; }","duration":"472.446662ms","start":"2026-09-22T01:44:53.016678Z","end":"2026-09-22T01:44:53.489125Z","steps":["trace[951669268] 'agreement among raft nodes before linearized reading' (duration: 471.856938ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:53.489515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.016657Z","time spent":"472.837442ms","remote":"127.0.0.1:57862","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-09-22T01:44:53.997355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.14069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:44:53.99756Z","caller":"traceutil/trace.go:171","msg":"trace[1808507046] transaction","detail":"{read_only:false; response_revision:2166; number_of_response:1; }","duration":"503.44168ms","start":"2026-09-22T01:44:53.494101Z","end":"2026-09-22T01:44:53.997543Z","steps":["trace[1808507046] 'process raft request' (duration: 353.038403ms)","trace[1808507046] 'compare' (duration: 149.972376ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:44:53.997623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.494084Z","time spent":"503.509242ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:44:53.997893Z","caller":"traceutil/trace.go:171","msg":"trace[1837744509] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"500.741164ms","start":"2026-09-22T01:44:53.497122Z","end":"2026-09-22T01:44:53.997863Z","steps":["trace[1837744509] 'process raft request' (duration: 500.338805ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:53.998121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.497106Z","time spent":"500.927218ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:44:54.08207Z","caller":"traceutil/trace.go:171","msg":"trace[917878761] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2252; }","duration":"448.199798ms","start":"2026-09-22T01:44:53.633846Z","end":"2026-09-22T01:44:54.082045Z","steps":["trace[917878761] 'read index received' (duration: 213.279182ms)","trace[917878761] 'applied index is now lower than readState.Index' (duration: 234.919566ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:44:54.082504Z","caller":"traceutil/trace.go:171","msg":"trace[767316619] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"520.308757ms","start":"2026-09-22T01:44:53.562177Z","end":"2026-09-22T01:44:54.082486Z","steps":["trace[767316619] 'process raft request' (duration: 519.700392ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:54.082511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.649249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:44:54.082708Z","caller":"traceutil/trace.go:171","msg":"trace[1597762528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2168; }","duration":"448.884205ms","start":"2026-09-22T01:44:53.633798Z","end":"2026-09-22T01:44:54.082683Z","steps":["trace[1597762528] 'agreement among raft nodes before linearized reading' (duration: 448.648899ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:54.082782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.56214Z","time spent":"520.403829ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:44:54.082962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.633782Z","time spent":"449.059609ms","remote":"127.0.0.1:59054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-22T01:44:54.663059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.781723ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:44:54.663309Z","caller":"traceutil/trace.go:171","msg":"trace[914032040] linearizableReadLoop","detail":"{readStateIndex:2257; appliedIndex:2255; }","duration":"581.154424ms","start":"2026-09-22T01:44:54.082135Z","end":"2026-09-22T01:44:54.663289Z","steps":["trace[914032040] 'read index received' (duration: 278.35359ms)","trace[914032040] 'applied index is now lower than readState.Index' (duration: 302.799834ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:44:54.663399Z","caller":"traceutil/trace.go:171","msg":"trace[1955440881] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"622.433015ms","start":"2026-09-22T01:44:54.040956Z","end":"2026-09-22T01:44:54.663389Z","steps":["trace[1955440881] 'process raft request' (duration: 622.189919ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:54.663463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:54.040927Z","time spent":"622.500986ms","remote":"127.0.0.1:59258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8537,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:44:54.663594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.240427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:44:54.663622Z","caller":"traceutil/trace.go:171","msg":"trace[351167900] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2170; }","duration":"579.296599ms","start":"2026-09-22T01:44:54.084316Z","end":"2026-09-22T01:44:54.663613Z","steps":["trace[351167900] 'agreement among raft nodes before linearized reading' (duration: 579.252398ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:54.663648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:54.0843Z","time spent":"579.34272ms","remote":"127.0.0.1:59058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-22T01:44:54.66366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"831.762747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1986"} {"level":"info","ts":"2026-09-22T01:44:54.66374Z","caller":"traceutil/trace.go:171","msg":"trace[1817836653] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:2170; }","duration":"831.89285ms","start":"2026-09-22T01:44:53.831825Z","end":"2026-09-22T01:44:54.663718Z","steps":["trace[1817836653] 'agreement among raft nodes before linearized reading' (duration: 831.665825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:54.663808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.831802Z","time spent":"831.996413ms","remote":"127.0.0.1:59270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2010,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-09-22T01:44:54.663758Z","caller":"traceutil/trace.go:171","msg":"trace[1323039468] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"759.445204ms","start":"2026-09-22T01:44:53.904249Z","end":"2026-09-22T01:44:54.663694Z","steps":["trace[1323039468] 'process raft request' (duration: 455.951303ms)","trace[1323039468] 'compare' (duration: 302.565198ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:44:54.664014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.245782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-09-22T01:44:54.66403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.908935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-22T01:44:54.664089Z","caller":"traceutil/trace.go:171","msg":"trace[1204067094] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2170; }","duration":"166.341634ms","start":"2026-09-22T01:44:54.497735Z","end":"2026-09-22T01:44:54.664077Z","steps":["trace[1204067094] 'agreement among raft nodes before linearized reading' (duration: 166.143869ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:44:54.6641Z","caller":"traceutil/trace.go:171","msg":"trace[1781011461] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2170; }","duration":"505.012647ms","start":"2026-09-22T01:44:54.159071Z","end":"2026-09-22T01:44:54.664083Z","steps":["trace[1781011461] 'agreement among raft nodes before linearized reading' (duration: 504.843973ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:54.664185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:54.159053Z","time spent":"505.08893ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-22T01:44:54.663927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.993114ms","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-09-22T01:44:54.664448Z","caller":"traceutil/trace.go:171","msg":"trace[1249822588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2170; }","duration":"650.560038ms","start":"2026-09-22T01:44:54.013876Z","end":"2026-09-22T01:44:54.664436Z","steps":["trace[1249822588] 'agreement among raft nodes before linearized reading' (duration: 649.965823ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:44:54.664482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:54.013856Z","time spent":"650.617129ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-22T01:44:54.664184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:44:53.904223Z","time spent":"759.772452ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:46:05.120938Z","caller":"traceutil/trace.go:171","msg":"trace[1940787515] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"126.033044ms","start":"2026-09-22T01:46:04.994875Z","end":"2026-09-22T01:46:05.120908Z","steps":["trace[1940787515] 'process raft request' (duration: 125.855148ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:46:05.120969Z","caller":"traceutil/trace.go:171","msg":"trace[1254515279] linearizableReadLoop","detail":"{readStateIndex:2755; appliedIndex:2755; }","duration":"121.775149ms","start":"2026-09-22T01:46:04.999165Z","end":"2026-09-22T01:46:05.12094Z","steps":["trace[1254515279] 'read index received' (duration: 121.766419ms)","trace[1254515279] 'applied index is now lower than readState.Index' (duration: 7.13µs)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:46:05.121143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.972295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-09-22T01:46:05.121174Z","caller":"traceutil/trace.go:171","msg":"trace[1040572473] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2651; }","duration":"122.018236ms","start":"2026-09-22T01:46:04.999149Z","end":"2026-09-22T01:46:05.121167Z","steps":["trace[1040572473] 'agreement among raft nodes before linearized reading' (duration: 121.863741ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:46:42.565896Z","caller":"traceutil/trace.go:171","msg":"trace[1870607746] transaction","detail":"{read_only:false; response_revision:2856; number_of_response:1; }","duration":"102.552729ms","start":"2026-09-22T01:46:42.463321Z","end":"2026-09-22T01:46:42.565874Z","steps":["trace[1870607746] 'process raft request' (duration: 102.343602ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.245189Z","caller":"traceutil/trace.go:171","msg":"trace[1608493000] transaction","detail":"{read_only:false; response_revision:4612; number_of_response:1; }","duration":"103.418407ms","start":"2026-09-22T01:51:02.141743Z","end":"2026-09-22T01:51:02.245161Z","steps":["trace[1608493000] 'process raft request' (duration: 46.551942ms)","trace[1608493000] 'compare' (duration: 56.5093ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:02.245592Z","caller":"traceutil/trace.go:171","msg":"trace[1893078446] transaction","detail":"{read_only:false; response_revision:4613; number_of_response:1; }","duration":"102.166496ms","start":"2026-09-22T01:51:02.14341Z","end":"2026-09-22T01:51:02.245577Z","steps":["trace[1893078446] 'process raft request' (duration: 101.576582ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.245737Z","caller":"traceutil/trace.go:171","msg":"trace[1389532649] transaction","detail":"{read_only:false; response_revision:4614; number_of_response:1; }","duration":"102.238509ms","start":"2026-09-22T01:51:02.143461Z","end":"2026-09-22T01:51:02.2457Z","steps":["trace[1389532649] 'process raft request' (duration: 101.565362ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.245782Z","caller":"traceutil/trace.go:171","msg":"trace[1750468791] transaction","detail":"{read_only:false; response_revision:4615; number_of_response:1; }","duration":"102.205028ms","start":"2026-09-22T01:51:02.143573Z","end":"2026-09-22T01:51:02.245778Z","steps":["trace[1750468791] 'process raft request' (duration: 101.50836ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.24582Z","caller":"traceutil/trace.go:171","msg":"trace[342989329] transaction","detail":"{read_only:false; response_revision:4616; number_of_response:1; }","duration":"102.203508ms","start":"2026-09-22T01:51:02.143613Z","end":"2026-09-22T01:51:02.245817Z","steps":["trace[342989329] 'process raft request' (duration: 101.497139ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.245851Z","caller":"traceutil/trace.go:171","msg":"trace[1749658041] transaction","detail":"{read_only:false; response_revision:4617; number_of_response:1; }","duration":"100.086461ms","start":"2026-09-22T01:51:02.145761Z","end":"2026-09-22T01:51:02.245848Z","steps":["trace[1749658041] 'process raft request' (duration: 99.378782ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.405144Z","caller":"traceutil/trace.go:171","msg":"trace[584968652] linearizableReadLoop","detail":"{readStateIndex:4816; appliedIndex:4815; }","duration":"147.550062ms","start":"2026-09-22T01:51:02.257568Z","end":"2026-09-22T01:51:02.405118Z","steps":["trace[584968652] 'read index received' (duration: 97.406042ms)","trace[584968652] 'applied index is now lower than readState.Index' (duration: 50.14182ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:02.405214Z","caller":"traceutil/trace.go:171","msg":"trace[1927857884] transaction","detail":"{read_only:false; response_revision:4629; number_of_response:1; }","duration":"147.668327ms","start":"2026-09-22T01:51:02.257508Z","end":"2026-09-22T01:51:02.405177Z","steps":["trace[1927857884] 'process raft request' (duration: 97.455844ms)","trace[1927857884] 'compare' (duration: 49.774325ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:02.405276Z","caller":"traceutil/trace.go:171","msg":"trace[1606005184] transaction","detail":"{read_only:false; response_revision:4632; number_of_response:1; }","duration":"147.561352ms","start":"2026-09-22T01:51:02.257695Z","end":"2026-09-22T01:51:02.405256Z","steps":["trace[1606005184] 'process raft request' (duration: 147.393325ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.405222Z","caller":"traceutil/trace.go:171","msg":"trace[1127249136] transaction","detail":"{read_only:false; response_revision:4630; number_of_response:1; }","duration":"147.567042ms","start":"2026-09-22T01:51:02.257624Z","end":"2026-09-22T01:51:02.405191Z","steps":["trace[1127249136] 'process raft request' (duration: 147.341653ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.405272Z","caller":"traceutil/trace.go:171","msg":"trace[1513020407] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"147.618445ms","start":"2026-09-22T01:51:02.257629Z","end":"2026-09-22T01:51:02.405247Z","steps":["trace[1513020407] 'process raft request' (duration: 147.376565ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:02.405356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.768511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12211"} {"level":"info","ts":"2026-09-22T01:51:02.40539Z","caller":"traceutil/trace.go:171","msg":"trace[718670308] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4633; }","duration":"147.843794ms","start":"2026-09-22T01:51:02.257536Z","end":"2026-09-22T01:51:02.40538Z","steps":["trace[718670308] 'agreement among raft nodes before linearized reading' (duration: 147.672807ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.405482Z","caller":"traceutil/trace.go:171","msg":"trace[1904306193] transaction","detail":"{read_only:false; response_revision:4633; number_of_response:1; }","duration":"147.74296ms","start":"2026-09-22T01:51:02.257715Z","end":"2026-09-22T01:51:02.405458Z","steps":["trace[1904306193] 'process raft request' (duration: 147.430257ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.405944Z","caller":"traceutil/trace.go:171","msg":"trace[178508740] transaction","detail":"{read_only:false; response_revision:4634; number_of_response:1; }","duration":"148.188008ms","start":"2026-09-22T01:51:02.257741Z","end":"2026-09-22T01:51:02.405929Z","steps":["trace[178508740] 'process raft request' (duration: 147.431817ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.406472Z","caller":"traceutil/trace.go:171","msg":"trace[1136333736] transaction","detail":"{read_only:false; response_revision:4638; number_of_response:1; }","duration":"148.648127ms","start":"2026-09-22T01:51:02.2578Z","end":"2026-09-22T01:51:02.406448Z","steps":["trace[1136333736] 'process raft request' (duration: 148.322443ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.406966Z","caller":"traceutil/trace.go:171","msg":"trace[1114306175] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"148.439848ms","start":"2026-09-22T01:51:02.258508Z","end":"2026-09-22T01:51:02.406948Z","steps":["trace[1114306175] 'process raft request' (duration: 147.673887ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.407018Z","caller":"traceutil/trace.go:171","msg":"trace[610609012] transaction","detail":"{read_only:false; response_revision:4641; number_of_response:1; }","duration":"148.22908ms","start":"2026-09-22T01:51:02.258771Z","end":"2026-09-22T01:51:02.407Z","steps":["trace[610609012] 'process raft request' (duration: 147.462379ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.407053Z","caller":"traceutil/trace.go:171","msg":"trace[1120487785] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"148.559143ms","start":"2026-09-22T01:51:02.258481Z","end":"2026-09-22T01:51:02.40704Z","steps":["trace[1120487785] 'process raft request' (duration: 147.673367ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.407158Z","caller":"traceutil/trace.go:171","msg":"trace[1192267986] transaction","detail":"{read_only:false; response_revision:4637; number_of_response:1; }","duration":"149.363486ms","start":"2026-09-22T01:51:02.257773Z","end":"2026-09-22T01:51:02.407136Z","steps":["trace[1192267986] 'process raft request' (duration: 148.299672ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.407229Z","caller":"traceutil/trace.go:171","msg":"trace[1407712750] transaction","detail":"{read_only:false; response_revision:4636; number_of_response:1; }","duration":"149.4766ms","start":"2026-09-22T01:51:02.257745Z","end":"2026-09-22T01:51:02.407221Z","steps":["trace[1407712750] 'process raft request' (duration: 148.296192ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.407209Z","caller":"traceutil/trace.go:171","msg":"trace[715753652] transaction","detail":"{read_only:false; response_revision:4635; number_of_response:1; }","duration":"149.428279ms","start":"2026-09-22T01:51:02.257743Z","end":"2026-09-22T01:51:02.407171Z","steps":["trace[715753652] 'process raft request' (duration: 147.98795ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.407428Z","caller":"traceutil/trace.go:171","msg":"trace[994446317] transaction","detail":"{read_only:false; response_revision:4642; number_of_response:1; }","duration":"143.867921ms","start":"2026-09-22T01:51:02.263547Z","end":"2026-09-22T01:51:02.407414Z","steps":["trace[994446317] 'process raft request' (duration: 142.715594ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.407725Z","caller":"traceutil/trace.go:171","msg":"trace[543688524] transaction","detail":"{read_only:false; response_revision:4643; number_of_response:1; }","duration":"121.976866ms","start":"2026-09-22T01:51:02.28573Z","end":"2026-09-22T01:51:02.407707Z","steps":["trace[543688524] 'process raft request' (duration: 120.60538ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.556719Z","caller":"traceutil/trace.go:171","msg":"trace[753941342] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"118.3749ms","start":"2026-09-22T01:51:02.438321Z","end":"2026-09-22T01:51:02.556696Z","steps":["trace[753941342] 'process raft request' (duration: 80.044003ms)","trace[753941342] 'compare' (duration: 37.952311ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:02.557154Z","caller":"traceutil/trace.go:171","msg":"trace[1282966288] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"106.39424ms","start":"2026-09-22T01:51:02.450745Z","end":"2026-09-22T01:51:02.557139Z","steps":["trace[1282966288] 'process raft request' (duration: 105.864438ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:02.558826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.737508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-09-22T01:51:02.558916Z","caller":"traceutil/trace.go:171","msg":"trace[1805663404] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4650; }","duration":"122.857433ms","start":"2026-09-22T01:51:02.436031Z","end":"2026-09-22T01:51:02.558888Z","steps":["trace[1805663404] 'agreement among raft nodes before linearized reading' (duration: 121.119761ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:02.789471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.97586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-22T01:51:02.789528Z","caller":"traceutil/trace.go:171","msg":"trace[80335342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4677; }","duration":"127.072174ms","start":"2026-09-22T01:51:02.662442Z","end":"2026-09-22T01:51:02.789514Z","steps":["trace[80335342] 'agreement among raft nodes before linearized reading' (duration: 126.927248ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.789728Z","caller":"traceutil/trace.go:171","msg":"trace[506342928] transaction","detail":"{read_only:false; response_revision:4676; number_of_response:1; }","duration":"101.145575ms","start":"2026-09-22T01:51:02.688576Z","end":"2026-09-22T01:51:02.789721Z","steps":["trace[506342928] 'process raft request' (duration: 100.517669ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.847822Z","caller":"traceutil/trace.go:171","msg":"trace[596723205] transaction","detail":"{read_only:false; response_revision:4678; number_of_response:1; }","duration":"114.639346ms","start":"2026-09-22T01:51:02.733166Z","end":"2026-09-22T01:51:02.847805Z","steps":["trace[596723205] 'process raft request' (duration: 110.113161ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.847954Z","caller":"traceutil/trace.go:171","msg":"trace[1054427700] transaction","detail":"{read_only:false; response_revision:4679; number_of_response:1; }","duration":"110.608192ms","start":"2026-09-22T01:51:02.737339Z","end":"2026-09-22T01:51:02.847948Z","steps":["trace[1054427700] 'process raft request' (duration: 109.887092ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.848032Z","caller":"traceutil/trace.go:171","msg":"trace[1111594608] transaction","detail":"{read_only:false; response_revision:4680; number_of_response:1; }","duration":"106.511724ms","start":"2026-09-22T01:51:02.741515Z","end":"2026-09-22T01:51:02.848027Z","steps":["trace[1111594608] 'process raft request' (duration: 105.742503ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.848162Z","caller":"traceutil/trace.go:171","msg":"trace[2006833770] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"106.446561ms","start":"2026-09-22T01:51:02.74171Z","end":"2026-09-22T01:51:02.848156Z","steps":["trace[2006833770] 'process raft request' (duration: 105.567136ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.848246Z","caller":"traceutil/trace.go:171","msg":"trace[1030086780] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"106.40492ms","start":"2026-09-22T01:51:02.741834Z","end":"2026-09-22T01:51:02.848238Z","steps":["trace[1030086780] 'process raft request' (duration: 105.472402ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.848334Z","caller":"traceutil/trace.go:171","msg":"trace[1722024109] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"105.633708ms","start":"2026-09-22T01:51:02.742694Z","end":"2026-09-22T01:51:02.848327Z","steps":["trace[1722024109] 'process raft request' (duration: 104.627077ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:02.848457Z","caller":"traceutil/trace.go:171","msg":"trace[48418434] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"105.242942ms","start":"2026-09-22T01:51:02.743194Z","end":"2026-09-22T01:51:02.848437Z","steps":["trace[48418434] 'process raft request' (duration: 104.145547ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:18.17303Z","caller":"traceutil/trace.go:171","msg":"trace[859031537] transaction","detail":"{read_only:false; response_revision:5006; number_of_response:1; }","duration":"157.776368ms","start":"2026-09-22T01:51:18.015228Z","end":"2026-09-22T01:51:18.173005Z","steps":["trace[859031537] 'process raft request' (duration: 157.649078ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.490617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.537893ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:18.49073Z","caller":"traceutil/trace.go:171","msg":"trace[1718048736] linearizableReadLoop","detail":"{readStateIndex:5203; appliedIndex:5201; }","duration":"424.883939ms","start":"2026-09-22T01:51:18.065825Z","end":"2026-09-22T01:51:18.490709Z","steps":["trace[1718048736] 'read index received' (duration: 107.103079ms)","trace[1718048736] 'applied index is now lower than readState.Index' (duration: 317.77922ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:18.490768Z","caller":"traceutil/trace.go:171","msg":"trace[1667703172] transaction","detail":"{read_only:false; response_revision:5007; number_of_response:1; }","duration":"475.147068ms","start":"2026-09-22T01:51:18.015606Z","end":"2026-09-22T01:51:18.490753Z","steps":["trace[1667703172] 'process raft request' (duration: 365.378185ms)","trace[1667703172] 'compare' (duration: 109.238153ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:18.49082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.015592Z","time spent":"475.204478ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:18.490898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.06157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:18.490944Z","caller":"traceutil/trace.go:171","msg":"trace[534578234] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:5007; }","duration":"425.14375ms","start":"2026-09-22T01:51:18.065787Z","end":"2026-09-22T01:51:18.490931Z","steps":["trace[534578234] 'agreement among raft nodes before linearized reading' (duration: 425.06403ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.49099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.065774Z","time spent":"425.20266ms","remote":"127.0.0.1:59138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-09-22T01:51:18.491063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.773988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-22T01:51:18.491086Z","caller":"traceutil/trace.go:171","msg":"trace[1839284684] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5007; }","duration":"201.821678ms","start":"2026-09-22T01:51:18.289256Z","end":"2026-09-22T01:51:18.491078Z","steps":["trace[1839284684] 'agreement among raft nodes before linearized reading' (duration: 201.742788ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.491082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.839602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-09-22T01:51:18.491172Z","caller":"traceutil/trace.go:171","msg":"trace[1147316042] range","detail":"{range_begin:/registry/masterleases/162.253.55.3; range_end:; response_count:1; response_revision:5007; }","duration":"394.980392ms","start":"2026-09-22T01:51:18.096171Z","end":"2026-09-22T01:51:18.491152Z","steps":["trace[1147316042] 'agreement among raft nodes before linearized reading' (duration: 394.743452ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.49123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.096139Z","time spent":"395.076812ms","remote":"127.0.0.1:59090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/162.253.55.3\" "} {"level":"warn","ts":"2026-09-22T01:51:18.491351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.445998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12971"} {"level":"info","ts":"2026-09-22T01:51:18.491372Z","caller":"traceutil/trace.go:171","msg":"trace[538475636] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5007; }","duration":"259.511448ms","start":"2026-09-22T01:51:18.231855Z","end":"2026-09-22T01:51:18.491367Z","steps":["trace[538475636] 'agreement among raft nodes before linearized reading' (duration: 259.459718ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.491419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.587989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-67c7c4d6bd-7kgzd.18d7819a70a7171b\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-09-22T01:51:18.491477Z","caller":"traceutil/trace.go:171","msg":"trace[172297228] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-67c7c4d6bd-7kgzd.18d7819a70a7171b; range_end:; response_count:1; response_revision:5007; }","duration":"259.69321ms","start":"2026-09-22T01:51:18.231769Z","end":"2026-09-22T01:51:18.491462Z","steps":["trace[172297228] 'agreement among raft nodes before linearized reading' (duration: 259.555019ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.85358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.441066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T01:51:18.853988Z","caller":"traceutil/trace.go:171","msg":"trace[1886313903] transaction","detail":"{read_only:false; response_revision:5011; number_of_response:1; }","duration":"334.549767ms","start":"2026-09-22T01:51:18.519415Z","end":"2026-09-22T01:51:18.853965Z","steps":["trace[1886313903] 'process raft request' (duration: 334.484787ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:18.854063Z","caller":"traceutil/trace.go:171","msg":"trace[338676641] transaction","detail":"{read_only:false; response_revision:5010; number_of_response:1; }","duration":"345.073242ms","start":"2026-09-22T01:51:18.508965Z","end":"2026-09-22T01:51:18.854038Z","steps":["trace[338676641] 'process raft request' (duration: 344.859982ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.854094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.51939Z","time spent":"334.647137ms","remote":"127.0.0.1:59090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":116,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:18.854163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.508937Z","time spent":"345.174153ms","remote":"127.0.0.1:59260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13277,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:18.854342Z","caller":"traceutil/trace.go:171","msg":"trace[1081439575] linearizableReadLoop","detail":"{readStateIndex:5206; appliedIndex:5203; }","duration":"358.257893ms","start":"2026-09-22T01:51:18.496068Z","end":"2026-09-22T01:51:18.854326Z","steps":["trace[1081439575] 'read index received' (duration: 22.459154ms)","trace[1081439575] 'applied index is now lower than readState.Index' (duration: 335.796509ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:18.854323Z","caller":"traceutil/trace.go:171","msg":"trace[566908612] transaction","detail":"{read_only:false; response_revision:5008; number_of_response:1; }","duration":"358.462944ms","start":"2026-09-22T01:51:18.495839Z","end":"2026-09-22T01:51:18.854302Z","steps":["trace[566908612] 'process raft request' (duration: 138.184477ms)","trace[566908612] 'compare' (duration: 219.308515ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:18.85437Z","caller":"traceutil/trace.go:171","msg":"trace[1536418705] transaction","detail":"{read_only:false; response_revision:5009; number_of_response:1; }","duration":"358.399294ms","start":"2026-09-22T01:51:18.495939Z","end":"2026-09-22T01:51:18.854338Z","steps":["trace[1536418705] 'process raft request' (duration: 357.759643ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.85453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.452393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-29c648ee-3dab-4c9c-aed3-739607032edd\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-09-22T01:51:18.854585Z","caller":"traceutil/trace.go:171","msg":"trace[877920533] range","detail":"{range_begin:/registry/persistentvolumes/pvc-29c648ee-3dab-4c9c-aed3-739607032edd; range_end:; response_count:1; response_revision:5011; }","duration":"358.528513ms","start":"2026-09-22T01:51:18.496038Z","end":"2026-09-22T01:51:18.854567Z","steps":["trace[877920533] 'agreement among raft nodes before linearized reading' (duration: 358.373133ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:18.854627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.49603Z","time spent":"358.584723ms","remote":"127.0.0.1:59228","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1474,"request content":"key:\"/registry/persistentvolumes/pvc-29c648ee-3dab-4c9c-aed3-739607032edd\" "} {"level":"warn","ts":"2026-09-22T01:51:18.854672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.495904Z","time spent":"358.573294ms","remote":"127.0.0.1:59122","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":881,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:18.85461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.495818Z","time spent":"358.593794ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:19.156251Z","caller":"traceutil/trace.go:171","msg":"trace[722540001] linearizableReadLoop","detail":"{readStateIndex:5209; appliedIndex:5208; }","duration":"301.847907ms","start":"2026-09-22T01:51:18.854383Z","end":"2026-09-22T01:51:19.156231Z","steps":["trace[722540001] 'read index received' (duration: 290.236697ms)","trace[722540001] 'applied index is now lower than readState.Index' (duration: 11.60998ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:19.156316Z","caller":"traceutil/trace.go:171","msg":"trace[393414858] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"365.511107ms","start":"2026-09-22T01:51:18.790757Z","end":"2026-09-22T01:51:19.156268Z","steps":["trace[393414858] 'process raft request' (duration: 353.882857ms)","trace[393414858] 'compare' (duration: 11.3201ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:19.156386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.028527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-22T01:51:19.156399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.468356ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-09-22T01:51:19.156445Z","caller":"traceutil/trace.go:171","msg":"trace[243275821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5012; }","duration":"524.097608ms","start":"2026-09-22T01:51:18.632334Z","end":"2026-09-22T01:51:19.156432Z","steps":["trace[243275821] 'agreement among raft nodes before linearized reading' (duration: 523.989287ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:19.156482Z","caller":"traceutil/trace.go:171","msg":"trace[1382659042] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:5012; }","duration":"441.588698ms","start":"2026-09-22T01:51:18.714876Z","end":"2026-09-22T01:51:19.156465Z","steps":["trace[1382659042] 'agreement among raft nodes before linearized reading' (duration: 441.389667ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.15653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.790718Z","time spent":"365.688127ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:19.156592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.71486Z","time spent":"441.658058ms","remote":"127.0.0.1:59558","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":16,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-09-22T01:51:19.156563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.632275Z","time spent":"524.277548ms","remote":"127.0.0.1:59054","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-22T01:51:19.369492Z","caller":"traceutil/trace.go:171","msg":"trace[539222959] transaction","detail":"{read_only:false; response_revision:5014; number_of_response:1; }","duration":"506.98644ms","start":"2026-09-22T01:51:18.86248Z","end":"2026-09-22T01:51:19.369466Z","steps":["trace[539222959] 'process raft request' (duration: 506.812909ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:19.3695Z","caller":"traceutil/trace.go:171","msg":"trace[2124083975] transaction","detail":"{read_only:false; response_revision:5013; number_of_response:1; }","duration":"507.04849ms","start":"2026-09-22T01:51:18.862417Z","end":"2026-09-22T01:51:19.369465Z","steps":["trace[2124083975] 'process raft request' (duration: 450.876094ms)","trace[2124083975] 'compare' (duration: 55.748545ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:19.369641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.862462Z","time spent":"507.10077ms","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1869,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:19.369653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.862388Z","time spent":"507.18467ms","remote":"127.0.0.1:59248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":906,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:19.369686Z","caller":"traceutil/trace.go:171","msg":"trace[813079973] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"506.561219ms","start":"2026-09-22T01:51:18.863108Z","end":"2026-09-22T01:51:19.369669Z","steps":["trace[813079973] 'process raft request' (duration: 506.307719ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:19.369499Z","caller":"traceutil/trace.go:171","msg":"trace[864749206] transaction","detail":"{read_only:false; response_revision:5015; number_of_response:1; }","duration":"506.387759ms","start":"2026-09-22T01:51:18.863086Z","end":"2026-09-22T01:51:19.369474Z","steps":["trace[864749206] 'process raft request' (duration: 506.265869ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:19.369746Z","caller":"traceutil/trace.go:171","msg":"trace[2028266215] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"420.952854ms","start":"2026-09-22T01:51:18.948747Z","end":"2026-09-22T01:51:19.369699Z","steps":["trace[2028266215] 'process raft request' (duration: 420.845164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.369792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.863092Z","time spent":"506.655769ms","remote":"127.0.0.1:59248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1283,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:19.369835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.948701Z","time spent":"421.090264ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:19.369878Z","caller":"traceutil/trace.go:171","msg":"trace[338858208] linearizableReadLoop","detail":"{readStateIndex:5215; appliedIndex:5209; }","duration":"213.555516ms","start":"2026-09-22T01:51:19.156309Z","end":"2026-09-22T01:51:19.369865Z","steps":["trace[338858208] 'read index received' (duration: 156.912179ms)","trace[338858208] 'applied index is now lower than readState.Index' (duration: 56.642307ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T01:51:19.369988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.978557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-09-22T01:51:19.37002Z","caller":"traceutil/trace.go:171","msg":"trace[1358405189] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5018; }","duration":"214.043217ms","start":"2026-09-22T01:51:19.155967Z","end":"2026-09-22T01:51:19.37001Z","steps":["trace[1358405189] 'agreement among raft nodes before linearized reading' (duration: 213.915606ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.370036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.506226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-22T01:51:19.370037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.502354ms","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":"info","ts":"2026-09-22T01:51:19.370078Z","caller":"traceutil/trace.go:171","msg":"trace[2119330478] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5018; }","duration":"382.570174ms","start":"2026-09-22T01:51:18.987496Z","end":"2026-09-22T01:51:19.370066Z","steps":["trace[2119330478] 'agreement among raft nodes before linearized reading' (duration: 382.395314ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:19.370087Z","caller":"traceutil/trace.go:171","msg":"trace[1838046884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5018; }","duration":"383.591736ms","start":"2026-09-22T01:51:18.986465Z","end":"2026-09-22T01:51:19.370057Z","steps":["trace[1838046884] 'agreement among raft nodes before linearized reading' (duration: 383.489786ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:19.370084Z","caller":"traceutil/trace.go:171","msg":"trace[1220468691] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"414.010184ms","start":"2026-09-22T01:51:18.956061Z","end":"2026-09-22T01:51:19.370072Z","steps":["trace[1220468691] 'process raft request' (duration: 413.606173ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.370112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.986449Z","time spent":"383.656976ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-22T01:51:19.370111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.987486Z","time spent":"382.614564ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-09-22T01:51:19.370143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.956044Z","time spent":"414.069384ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:19.370146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.442484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T01:51:19.370181Z","caller":"traceutil/trace.go:171","msg":"trace[1341564876] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5018; }","duration":"212.517084ms","start":"2026-09-22T01:51:19.157654Z","end":"2026-09-22T01:51:19.370171Z","steps":["trace[1341564876] 'agreement among raft nodes before linearized reading' (duration: 212.460304ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.370237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.784526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:420"} {"level":"info","ts":"2026-09-22T01:51:19.370261Z","caller":"traceutil/trace.go:171","msg":"trace[13136427] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5018; }","duration":"510.848376ms","start":"2026-09-22T01:51:18.859404Z","end":"2026-09-22T01:51:19.370253Z","steps":["trace[13136427] 'agreement among raft nodes before linearized reading' (duration: 510.803716ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.370282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.859383Z","time spent":"510.893396ms","remote":"127.0.0.1:59248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":444,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-09-22T01:51:19.370277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.029692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-09-22T01:51:19.370313Z","caller":"traceutil/trace.go:171","msg":"trace[281577740] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:5018; }","duration":"106.065812ms","start":"2026-09-22T01:51:19.264235Z","end":"2026-09-22T01:51:19.370301Z","steps":["trace[281577740] 'agreement among raft nodes before linearized reading' (duration: 105.970122ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.370839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:18.86307Z","time spent":"506.718049ms","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1455,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:19.699524Z","caller":"traceutil/trace.go:171","msg":"trace[173050708] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"323.582455ms","start":"2026-09-22T01:51:19.375914Z","end":"2026-09-22T01:51:19.699496Z","steps":["trace[173050708] 'process raft request' (duration: 322.937344ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.699685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:19.375898Z","time spent":"323.714605ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:19.729238Z","caller":"traceutil/trace.go:171","msg":"trace[2127748487] linearizableReadLoop","detail":"{readStateIndex:5217; appliedIndex:5215; }","duration":"352.540925ms","start":"2026-09-22T01:51:19.376682Z","end":"2026-09-22T01:51:19.729223Z","steps":["trace[2127748487] 'read index received' (duration: 322.186073ms)","trace[2127748487] 'applied index is now lower than readState.Index' (duration: 30.354312ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T01:51:19.72943Z","caller":"traceutil/trace.go:171","msg":"trace[1261959672] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"353.311966ms","start":"2026-09-22T01:51:19.376112Z","end":"2026-09-22T01:51:19.729424Z","steps":["trace[1261959672] 'process raft request' (duration: 352.981026ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.729507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:19.376089Z","time spent":"353.368206ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-22T01:51:19.729671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.34093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-09-22T01:51:19.72969Z","caller":"traceutil/trace.go:171","msg":"trace[1368796783] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5023; }","duration":"326.3609ms","start":"2026-09-22T01:51:19.403325Z","end":"2026-09-22T01:51:19.729686Z","steps":["trace[1368796783] 'agreement among raft nodes before linearized reading' (duration: 326.290469ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.729703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:19.403281Z","time spent":"326.41941ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-09-22T01:51:19.729689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.983546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-09-22T01:51:19.729804Z","caller":"traceutil/trace.go:171","msg":"trace[1447832100] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5023; }","duration":"353.109166ms","start":"2026-09-22T01:51:19.376678Z","end":"2026-09-22T01:51:19.729787Z","steps":["trace[1447832100] 'agreement among raft nodes before linearized reading' (duration: 352.924315ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.72986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:19.376649Z","time spent":"353.201516ms","remote":"127.0.0.1:59358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-09-22T01:51:19.730057Z","caller":"traceutil/trace.go:171","msg":"trace[1429736765] transaction","detail":"{read_only:false; response_revision:5021; number_of_response:1; }","duration":"352.153204ms","start":"2026-09-22T01:51:19.377893Z","end":"2026-09-22T01:51:19.730046Z","steps":["trace[1429736765] 'process raft request' (duration: 351.269673ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:19.730087Z","caller":"traceutil/trace.go:171","msg":"trace[1578269170] transaction","detail":"{read_only:false; response_revision:5022; number_of_response:1; }","duration":"212.592305ms","start":"2026-09-22T01:51:19.517489Z","end":"2026-09-22T01:51:19.730081Z","steps":["trace[1578269170] 'process raft request' (duration: 211.692734ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T01:51:19.730134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T01:51:19.377875Z","time spent":"352.210454ms","remote":"127.0.0.1:59342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T01:51:19.730068Z","caller":"traceutil/trace.go:171","msg":"trace[1225837693] transaction","detail":"{read_only:false; response_revision:5023; number_of_response:1; }","duration":"131.538856ms","start":"2026-09-22T01:51:19.598522Z","end":"2026-09-22T01:51:19.730061Z","steps":["trace[1225837693] 'process raft request' (duration: 130.681755ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:25.322865Z","caller":"traceutil/trace.go:171","msg":"trace[370620415] transaction","detail":"{read_only:false; response_revision:5124; number_of_response:1; }","duration":"117.97364ms","start":"2026-09-22T01:51:25.204866Z","end":"2026-09-22T01:51:25.32284Z","steps":["trace[370620415] 'process raft request' (duration: 113.048887ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:51:44.842209Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2869} {"level":"info","ts":"2026-09-22T01:51:44.920551Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2869,"took":"76.820926ms","hash":562087172,"current-db-size-bytes":51855360,"current-db-size":"52 MB","current-db-size-in-use-bytes":27480064,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-22T01:51:44.920624Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":562087172,"revision":2869,"compact-revision":-1} {"level":"info","ts":"2026-09-22T01:55:41.300356Z","caller":"traceutil/trace.go:171","msg":"trace[1753245123] transaction","detail":"{read_only:false; response_revision:7046; number_of_response:1; }","duration":"118.894679ms","start":"2026-09-22T01:55:41.181433Z","end":"2026-09-22T01:55:41.300327Z","steps":["trace[1753245123] 'process raft request' (duration: 118.480729ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T01:56:44.84919Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5331} {"level":"info","ts":"2026-09-22T01:56:44.936237Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5331,"took":"85.898159ms","hash":397359292,"current-db-size-bytes":51855360,"current-db-size":"52 MB","current-db-size-in-use-bytes":18792448,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-22T01:56:44.936311Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":397359292,"revision":5331,"compact-revision":2869}