{"level":"warn","ts":"2026-05-21T02:55:27.665029Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T02:55:27.665135Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-21T02:55:27.665339Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-21T02:55:27.665358Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-05-21T02:55:27.665389Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T02:55:27.666259Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-05-21T02:55:27.666621Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-21T02:55:27.673912Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.45417ms"} {"level":"info","ts":"2026-05-21T02:55:27.680469Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-05-21T02:55:27.680853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-21T02:55:27.680892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-05-21T02:55:27.680955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-21T02:55:27.680973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-05-21T02:55:27.681058Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-05-21T02:55:27.689911Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-21T02:55:27.69103Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-21T02:55:27.692066Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-21T02:55:27.694411Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-21T02:55:27.694528Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-21T02:55:27.695456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-05-21T02:55:27.695605Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-05-21T02:55:27.695733Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T02:55:27.695808Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T02:55:27.695833Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-21T02:55:27.701461Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-21T02:55:27.701605Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-05-21T02:55:27.70167Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-05-21T02:55:27.701843Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-21T02:55:27.701898Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-21T02:55:28.382371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-21T02:55:28.382444Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-21T02:55:28.382471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-05-21T02:55:28.382488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-05-21T02:55:28.382496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-05-21T02:55:28.382515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-05-21T02:55:28.382525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-05-21T02:55:28.383564Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-05-21T02:55:28.383611Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T02:55:28.383844Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-21T02:55:28.384279Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-21T02:55:28.384297Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-21T02:55:28.384278Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:55:28.385791Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:55:28.385926Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:55:28.385955Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-21T02:55:28.386524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-05-21T02:55:28.386677Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-21T02:55:37.382233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.343608ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:55:37.382716Z","caller":"traceutil/trace.go:171","msg":"trace[445405028] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:308; }","duration":"126.922054ms","start":"2026-05-21T02:55:37.255775Z","end":"2026-05-21T02:55:37.382697Z","steps":["trace[445405028] 'read index received' (duration: 7.202165ms)","trace[445405028] 'applied index is now lower than readState.Index' (duration: 119.717909ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:55:37.382746Z","caller":"traceutil/trace.go:171","msg":"trace[614194719] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"158.97218ms","start":"2026-05-21T02:55:37.223741Z","end":"2026-05-21T02:55:37.382714Z","steps":["trace[614194719] 'process raft request' (duration: 39.365364ms)","trace[614194719] 'compare' (duration: 118.147812ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:55:37.382886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.11464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:55:37.382939Z","caller":"traceutil/trace.go:171","msg":"trace[1212945009] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:0; response_revision:296; }","duration":"127.215533ms","start":"2026-05-21T02:55:37.255712Z","end":"2026-05-21T02:55:37.382927Z","steps":["trace[1212945009] 'agreement among raft nodes before linearized reading' (duration: 127.088279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:55:37.986854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.803051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-05-21T02:55:37.986914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.608754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-05-21T02:55:37.987017Z","caller":"traceutil/trace.go:171","msg":"trace[1081635491] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:303; }","duration":"130.773338ms","start":"2026-05-21T02:55:37.856224Z","end":"2026-05-21T02:55:37.986997Z","steps":["trace[1081635491] 'range keys from in-memory index tree' (duration: 130.472919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:55:37.987029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.158861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-05-21T02:55:37.987017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.564892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T02:55:37.987088Z","caller":"traceutil/trace.go:171","msg":"trace[8535407] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:303; }","duration":"181.268904ms","start":"2026-05-21T02:55:37.805792Z","end":"2026-05-21T02:55:37.987061Z","steps":["trace[8535407] 'range keys from in-memory index tree' (duration: 180.762738ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:55:37.987103Z","caller":"traceutil/trace.go:171","msg":"trace[2106692131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:303; }","duration":"135.700236ms","start":"2026-05-21T02:55:37.85138Z","end":"2026-05-21T02:55:37.98708Z","steps":["trace[2106692131] 'range keys from in-memory index tree' (duration: 135.203971ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:55:37.987649Z","caller":"traceutil/trace.go:171","msg":"trace[2136443804] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:303; }","duration":"230.679387ms","start":"2026-05-21T02:55:37.756942Z","end":"2026-05-21T02:55:37.987622Z","steps":["trace[2136443804] 'range keys from in-memory index tree' (duration: 229.645596ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:55:38.143844Z","caller":"traceutil/trace.go:171","msg":"trace[916721390] linearizableReadLoop","detail":"{readStateIndex:318; appliedIndex:316; }","duration":"136.833344ms","start":"2026-05-21T02:55:38.006984Z","end":"2026-05-21T02:55:38.143818Z","steps":["trace[916721390] 'read index received' (duration: 63.525677ms)","trace[916721390] 'applied index is now lower than readState.Index' (duration: 73.306397ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:55:38.143957Z","caller":"traceutil/trace.go:171","msg":"trace[29346444] transaction","detail":"{read_only:false; response_revision:305; number_of_response:1; }","duration":"147.645395ms","start":"2026-05-21T02:55:37.99628Z","end":"2026-05-21T02:55:38.143925Z","steps":["trace[29346444] 'process raft request' (duration: 102.406448ms)","trace[29346444] 'compare' (duration: 44.99864ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:55:38.144083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.076561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-21T02:55:38.144174Z","caller":"traceutil/trace.go:171","msg":"trace[1985060243] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:305; }","duration":"137.201384ms","start":"2026-05-21T02:55:38.006947Z","end":"2026-05-21T02:55:38.144148Z","steps":["trace[1985060243] 'agreement among raft nodes before linearized reading' (duration: 136.984698ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:55:39.195383Z","caller":"traceutil/trace.go:171","msg":"trace[1325871617] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"156.575367ms","start":"2026-05-21T02:55:39.03878Z","end":"2026-05-21T02:55:39.195355Z","steps":["trace[1325871617] 'process raft request' (duration: 142.199675ms)","trace[1325871617] 'compare' (duration: 14.201576ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:55:51.648376Z","caller":"traceutil/trace.go:171","msg":"trace[869081728] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:402; }","duration":"197.237708ms","start":"2026-05-21T02:55:51.451118Z","end":"2026-05-21T02:55:51.648356Z","steps":["trace[869081728] 'read index received' (duration: 196.987192ms)","trace[869081728] 'applied index is now lower than readState.Index' (duration: 249.646µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:55:51.648434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:55:51.306239Z","time spent":"342.188011ms","remote":"127.0.0.1:39294","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-21T02:55:51.648701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.562228ms","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-05-21T02:55:51.648785Z","caller":"traceutil/trace.go:171","msg":"trace[1408076361] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:386; }","duration":"197.698931ms","start":"2026-05-21T02:55:51.451066Z","end":"2026-05-21T02:55:51.648765Z","steps":["trace[1408076361] 'agreement among raft nodes before linearized reading' (duration: 197.463406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:55:51.648771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.22322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4374"} {"level":"info","ts":"2026-05-21T02:55:51.648861Z","caller":"traceutil/trace.go:171","msg":"trace[2085797827] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:386; }","duration":"131.357513ms","start":"2026-05-21T02:55:51.517484Z","end":"2026-05-21T02:55:51.648841Z","steps":["trace[2085797827] 'agreement among raft nodes before linearized reading' (duration: 131.200539ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:55:56.741455Z","caller":"traceutil/trace.go:171","msg":"trace[1036683840] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"111.343649ms","start":"2026-05-21T02:55:56.630079Z","end":"2026-05-21T02:55:56.741422Z","steps":["trace[1036683840] 'process raft request' (duration: 111.176095ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:07.626535Z","caller":"traceutil/trace.go:171","msg":"trace[239723789] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"699.072453ms","start":"2026-05-21T02:56:06.92743Z","end":"2026-05-21T02:56:07.626502Z","steps":["trace[239723789] 'process raft request' (duration: 680.25441ms)","trace[239723789] 'compare' (duration: 18.522297ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:07.626592Z","caller":"traceutil/trace.go:171","msg":"trace[303256872] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"697.421065ms","start":"2026-05-21T02:56:06.929149Z","end":"2026-05-21T02:56:07.62657Z","steps":["trace[303256872] 'process raft request' (duration: 697.231591ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:07.6267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:06.927422Z","time spent":"699.192736ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:56:07.626727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:06.929134Z","time spent":"697.528197ms","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T02:56:08.228586Z","caller":"traceutil/trace.go:171","msg":"trace[566955565] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"231.775479ms","start":"2026-05-21T02:56:07.996788Z","end":"2026-05-21T02:56:08.228564Z","steps":["trace[566955565] 'process raft request' (duration: 198.968471ms)","trace[566955565] 'compare' (duration: 32.219664ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:08.228568Z","caller":"traceutil/trace.go:171","msg":"trace[1536050316] linearizableReadLoop","detail":"{readStateIndex:571; appliedIndex:570; }","duration":"165.733614ms","start":"2026-05-21T02:56:08.062807Z","end":"2026-05-21T02:56:08.228541Z","steps":["trace[1536050316] 'read index received' (duration: 132.926877ms)","trace[1536050316] 'applied index is now lower than readState.Index' (duration: 32.802197ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:08.228716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.890887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:56:08.228744Z","caller":"traceutil/trace.go:171","msg":"trace[67031978] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:546; }","duration":"165.948278ms","start":"2026-05-21T02:56:08.062786Z","end":"2026-05-21T02:56:08.228734Z","steps":["trace[67031978] 'agreement among raft nodes before linearized reading' (duration: 165.891517ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:08.228754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.739123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:56:08.228774Z","caller":"traceutil/trace.go:171","msg":"trace[458254137] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:546; }","duration":"165.824395ms","start":"2026-05-21T02:56:08.062944Z","end":"2026-05-21T02:56:08.228768Z","steps":["trace[458254137] 'agreement among raft nodes before linearized reading' (duration: 165.751423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:08.637749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.929257ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:56:08.637871Z","caller":"traceutil/trace.go:171","msg":"trace[1876292963] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"375.397083ms","start":"2026-05-21T02:56:08.262454Z","end":"2026-05-21T02:56:08.637851Z","steps":["trace[1876292963] 'process raft request' (duration: 162.286582ms)","trace[1876292963] 'compare' (duration: 212.795343ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:08.637935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:08.262445Z","time spent":"375.459004ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:56:09.753067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.966984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:56:09.753444Z","caller":"traceutil/trace.go:171","msg":"trace[2100032517] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"1.484259158s","start":"2026-05-21T02:56:08.269168Z","end":"2026-05-21T02:56:09.753427Z","steps":["trace[2100032517] 'process raft request' (duration: 952.863424ms)","trace[2100032517] 'compare' (duration: 530.722528ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:09.753499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:08.269145Z","time spent":"1.484326749s","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:09.753649Z","caller":"traceutil/trace.go:171","msg":"trace[162380665] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"1.482082176s","start":"2026-05-21T02:56:08.271512Z","end":"2026-05-21T02:56:09.753594Z","steps":["trace[162380665] 'process raft request' (duration: 1.481644577s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:09.753871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:08.271493Z","time spent":"1.482257332s","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65412,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:09.753921Z","caller":"traceutil/trace.go:171","msg":"trace[141695557] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:572; }","duration":"1.449539376s","start":"2026-05-21T02:56:08.304369Z","end":"2026-05-21T02:56:09.753908Z","steps":["trace[141695557] 'read index received' (duration: 120.305801ms)","trace[141695557] 'applied index is now lower than readState.Index' (duration: 1.329232755s)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:09.753999Z","caller":"traceutil/trace.go:171","msg":"trace[1440449572] transaction","detail":"{read_only:false; response_revision:550; number_of_response:1; }","duration":"1.474011507s","start":"2026-05-21T02:56:08.279979Z","end":"2026-05-21T02:56:09.75399Z","steps":["trace[1440449572] 'process raft request' (duration: 1.473570796s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:09.754044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:08.279952Z","time spent":"1.474067199s","remote":"127.0.0.1:39314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T02:56:09.754063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.172995032s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:56:09.754095Z","caller":"traceutil/trace.go:171","msg":"trace[504921842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"1.173070694s","start":"2026-05-21T02:56:08.581015Z","end":"2026-05-21T02:56:09.754086Z","steps":["trace[504921842] 'agreement among raft nodes before linearized reading' (duration: 1.173004273s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:09.754114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:08.580996Z","time spent":"1.173113464s","remote":"127.0.0.1:39264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T02:56:09.754114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.449748961s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-21T02:56:09.754184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"960.001255ms","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-05-21T02:56:09.754164Z","caller":"traceutil/trace.go:171","msg":"trace[292622639] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:550; }","duration":"1.449826512s","start":"2026-05-21T02:56:08.30432Z","end":"2026-05-21T02:56:09.754146Z","steps":["trace[292622639] 'agreement among raft nodes before linearized reading' (duration: 1.44972739s)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:09.754205Z","caller":"traceutil/trace.go:171","msg":"trace[7818613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"960.054886ms","start":"2026-05-21T02:56:08.794144Z","end":"2026-05-21T02:56:09.754199Z","steps":["trace[7818613] 'agreement among raft nodes before linearized reading' (duration: 959.966945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:09.754228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:08.794127Z","time spent":"960.097627ms","remote":"127.0.0.1:39530","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-05-21T02:56:09.754239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:08.304302Z","time spent":"1.449926495s","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-21T02:56:13.983537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.000403ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:56:13.983626Z","caller":"traceutil/trace.go:171","msg":"trace[2034479917] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"202.899785ms","start":"2026-05-21T02:56:13.780713Z","end":"2026-05-21T02:56:13.983612Z","steps":["trace[2034479917] 'read index received' (duration: 66.779199ms)","trace[2034479917] 'applied index is now lower than readState.Index' (duration: 136.119296ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:13.983852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.065428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T02:56:13.98388Z","caller":"traceutil/trace.go:171","msg":"trace[524352952] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:588; }","duration":"203.184691ms","start":"2026-05-21T02:56:13.780684Z","end":"2026-05-21T02:56:13.983869Z","steps":["trace[524352952] 'agreement among raft nodes before linearized reading' (duration: 202.981737ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:13.983725Z","caller":"traceutil/trace.go:171","msg":"trace[1846934496] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"308.610263ms","start":"2026-05-21T02:56:13.675065Z","end":"2026-05-21T02:56:13.983676Z","steps":["trace[1846934496] 'process raft request' (duration: 172.405385ms)","trace[1846934496] 'compare' (duration: 135.916351ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:13.984737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:13.675034Z","time spent":"309.420052ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:14.049448Z","caller":"traceutil/trace.go:171","msg":"trace[1719367366] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"259.899806ms","start":"2026-05-21T02:56:13.789508Z","end":"2026-05-21T02:56:14.049408Z","steps":["trace[1719367366] 'process raft request' (duration: 259.390675ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:14.049625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.236447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-21T02:56:14.050169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.645336ms","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-05-21T02:56:14.050255Z","caller":"traceutil/trace.go:171","msg":"trace[1078419376] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:589; }","duration":"265.79302ms","start":"2026-05-21T02:56:13.78445Z","end":"2026-05-21T02:56:14.050243Z","steps":["trace[1078419376] 'agreement among raft nodes before linearized reading' (duration: 265.443891ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:14.049828Z","caller":"traceutil/trace.go:171","msg":"trace[959395768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:589; }","duration":"265.593705ms","start":"2026-05-21T02:56:13.784213Z","end":"2026-05-21T02:56:14.049807Z","steps":["trace[959395768] 'agreement among raft nodes before linearized reading' (duration: 265.171506ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:14.356972Z","caller":"traceutil/trace.go:171","msg":"trace[1881878970] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"369.878276ms","start":"2026-05-21T02:56:13.987071Z","end":"2026-05-21T02:56:14.356949Z","steps":["trace[1881878970] 'process raft request' (duration: 369.756433ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:14.357133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:13.98705Z","time spent":"370.019119ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:14.520229Z","caller":"traceutil/trace.go:171","msg":"trace[835836188] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"404.225604ms","start":"2026-05-21T02:56:14.115977Z","end":"2026-05-21T02:56:14.520203Z","steps":["trace[835836188] 'process raft request' (duration: 404.167193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:14.520372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:14.115964Z","time spent":"404.343826ms","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-21T02:56:14.52072Z","caller":"traceutil/trace.go:171","msg":"trace[8527071] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"449.606492ms","start":"2026-05-21T02:56:14.071096Z","end":"2026-05-21T02:56:14.520702Z","steps":["trace[8527071] 'process raft request' (duration: 448.946548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:14.520815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:14.071073Z","time spent":"449.691475ms","remote":"127.0.0.1:39446","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:14.521023Z","caller":"traceutil/trace.go:171","msg":"trace[133891363] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"465.631882ms","start":"2026-05-21T02:56:14.055369Z","end":"2026-05-21T02:56:14.521001Z","steps":["trace[133891363] 'process raft request' (duration: 440.353124ms)","trace[133891363] 'compare' (duration: 24.140833ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:14.52114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:14.055349Z","time spent":"465.729274ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:14.521305Z","caller":"traceutil/trace.go:171","msg":"trace[159219326] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"464.958098ms","start":"2026-05-21T02:56:14.056338Z","end":"2026-05-21T02:56:14.521296Z","steps":["trace[159219326] 'process raft request' (duration: 463.646128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:14.521344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:14.056325Z","time spent":"465.001139ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:56:16.188303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528899381s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T02:56:16.188377Z","caller":"traceutil/trace.go:171","msg":"trace[1103324933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:594; }","duration":"1.529001284s","start":"2026-05-21T02:56:14.659355Z","end":"2026-05-21T02:56:16.188356Z","steps":["trace[1103324933] 'range keys from in-memory index tree' (duration: 1.528767749s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:16.188416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:14.659341Z","time spent":"1.529064805s","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-21T02:56:16.227952Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.301766851s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T02:56:16.232307Z","caller":"traceutil/trace.go:171","msg":"trace[2001795798] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"302.433732ms","start":"2026-05-21T02:56:15.929818Z","end":"2026-05-21T02:56:16.232252Z","steps":["trace[2001795798] 'read index received' (duration: 298.71072ms)","trace[2001795798] 'applied index is now lower than readState.Index' (duration: 3.719742ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:16.232479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.646997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:56:16.232613Z","caller":"traceutil/trace.go:171","msg":"trace[1895862838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:596; }","duration":"302.805061ms","start":"2026-05-21T02:56:15.929779Z","end":"2026-05-21T02:56:16.232584Z","steps":["trace[1895862838] 'agreement among raft nodes before linearized reading' (duration: 302.645627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:16.232644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:15.929765Z","time spent":"302.870042ms","remote":"127.0.0.1:39264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-21T02:56:16.233005Z","caller":"traceutil/trace.go:171","msg":"trace[1466087764] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"1.308184555s","start":"2026-05-21T02:56:14.924806Z","end":"2026-05-21T02:56:16.23299Z","steps":["trace[1466087764] 'process raft request' (duration: 1.304525353s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:16.233101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:14.924783Z","time spent":"1.308259016s","remote":"127.0.0.1:39350","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:17.453691Z","caller":"traceutil/trace.go:171","msg":"trace[591829824] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"243.91155ms","start":"2026-05-21T02:56:17.209754Z","end":"2026-05-21T02:56:17.453665Z","steps":["trace[591829824] 'process raft request' (duration: 243.257256ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:24.505143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.423708ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:56:24.505254Z","caller":"traceutil/trace.go:171","msg":"trace[2078999807] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"224.29685ms","start":"2026-05-21T02:56:24.280938Z","end":"2026-05-21T02:56:24.505235Z","steps":["trace[2078999807] 'process raft request' (duration: 113.716799ms)","trace[2078999807] 'compare' (duration: 110.306236ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:24.507165Z","caller":"traceutil/trace.go:171","msg":"trace[858272483] linearizableReadLoop","detail":"{readStateIndex:739; appliedIndex:738; }","duration":"104.32889ms","start":"2026-05-21T02:56:24.402821Z","end":"2026-05-21T02:56:24.50715Z","steps":["trace[858272483] 'read index received' (duration: 104.257108ms)","trace[858272483] 'applied index is now lower than readState.Index' (duration: 71.342µs)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:24.507396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.560435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T02:56:24.507421Z","caller":"traceutil/trace.go:171","msg":"trace[505120844] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:709; }","duration":"104.630737ms","start":"2026-05-21T02:56:24.402782Z","end":"2026-05-21T02:56:24.507413Z","steps":["trace[505120844] 'agreement among raft nodes before linearized reading' (duration: 104.427572ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:24.508012Z","caller":"traceutil/trace.go:171","msg":"trace[2028652413] transaction","detail":"{read_only:false; number_of_response:0; response_revision:709; }","duration":"225.913465ms","start":"2026-05-21T02:56:24.281461Z","end":"2026-05-21T02:56:24.507374Z","steps":["trace[2028652413] 'process raft request' (duration: 225.650719ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:25.166295Z","caller":"traceutil/trace.go:171","msg":"trace[669356053] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"142.57408ms","start":"2026-05-21T02:56:25.023697Z","end":"2026-05-21T02:56:25.166271Z","steps":["trace[669356053] 'process raft request' (duration: 142.419506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:26.545307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.446151ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-21T02:56:26.54543Z","caller":"traceutil/trace.go:171","msg":"trace[694377548] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"295.737395ms","start":"2026-05-21T02:56:26.249681Z","end":"2026-05-21T02:56:26.545418Z","steps":["trace[694377548] 'process raft request' (duration: 55.029727ms)","trace[694377548] 'compare' (duration: 240.35818ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:26.551656Z","caller":"traceutil/trace.go:171","msg":"trace[1995253693] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:748; }","duration":"271.097862ms","start":"2026-05-21T02:56:26.280529Z","end":"2026-05-21T02:56:26.551627Z","steps":["trace[1995253693] 'read index received' (duration: 24.184185ms)","trace[1995253693] 'applied index is now lower than readState.Index' (duration: 246.912847ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:26.551939Z","caller":"traceutil/trace.go:171","msg":"trace[511211974] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"300.074045ms","start":"2026-05-21T02:56:26.251855Z","end":"2026-05-21T02:56:26.55193Z","steps":["trace[511211974] 'process raft request' (duration: 299.684217ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:26.552067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:26.251831Z","time spent":"300.134927ms","remote":"127.0.0.1:60730","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2258,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-21T02:56:26.552256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.726284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-21T02:56:26.552286Z","caller":"traceutil/trace.go:171","msg":"trace[1299962534] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:720; }","duration":"271.762305ms","start":"2026-05-21T02:56:26.280517Z","end":"2026-05-21T02:56:26.552279Z","steps":["trace[1299962534] 'agreement among raft nodes before linearized reading' (duration: 271.631452ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:26.669605Z","caller":"traceutil/trace.go:171","msg":"trace[724402146] linearizableReadLoop","detail":"{readStateIndex:751; appliedIndex:750; }","duration":"117.863326ms","start":"2026-05-21T02:56:26.551726Z","end":"2026-05-21T02:56:26.669589Z","steps":["trace[724402146] 'read index received' (duration: 114.382164ms)","trace[724402146] 'applied index is now lower than readState.Index' (duration: 3.479982ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:26.669624Z","caller":"traceutil/trace.go:171","msg":"trace[730587488] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"113.71872ms","start":"2026-05-21T02:56:26.55588Z","end":"2026-05-21T02:56:26.669599Z","steps":["trace[730587488] 'process raft request' (duration: 113.651778ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:26.669696Z","caller":"traceutil/trace.go:171","msg":"trace[1923007118] transaction","detail":"{read_only:false; response_revision:721; number_of_response:1; }","duration":"118.260265ms","start":"2026-05-21T02:56:26.551427Z","end":"2026-05-21T02:56:26.669687Z","steps":["trace[1923007118] 'process raft request' (duration: 114.64921ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:26.66989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.332393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T02:56:26.669919Z","caller":"traceutil/trace.go:171","msg":"trace[643032413] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:722; }","duration":"127.404935ms","start":"2026-05-21T02:56:26.542507Z","end":"2026-05-21T02:56:26.669912Z","steps":["trace[643032413] 'agreement among raft nodes before linearized reading' (duration: 127.299023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:32.141688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.901339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:56:32.141806Z","caller":"traceutil/trace.go:171","msg":"trace[1411354947] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:763; }","duration":"560.052442ms","start":"2026-05-21T02:56:31.581726Z","end":"2026-05-21T02:56:32.141778Z","steps":["trace[1411354947] 'range keys from in-memory index tree' (duration: 559.841538ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:32.1418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.951327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-21T02:56:32.141861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:31.5817Z","time spent":"560.143945ms","remote":"127.0.0.1:39264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-21T02:56:32.141867Z","caller":"traceutil/trace.go:171","msg":"trace[863241560] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:763; }","duration":"164.051299ms","start":"2026-05-21T02:56:31.9778Z","end":"2026-05-21T02:56:32.141851Z","steps":["trace[863241560] 'count revisions from in-memory index tree' (duration: 163.884336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:32.142838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.632143ms","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-05-21T02:56:32.142898Z","caller":"traceutil/trace.go:171","msg":"trace[713920050] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:763; }","duration":"172.716695ms","start":"2026-05-21T02:56:31.970168Z","end":"2026-05-21T02:56:32.142884Z","steps":["trace[713920050] 'range keys from in-memory index tree' (duration: 171.339098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:32.644089Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393493735196531,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T02:56:33.14468Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6530393493735196531,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-21T02:56:33.16414Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.065111655s","expected-duration":"1s"} {"level":"info","ts":"2026-05-21T02:56:33.164693Z","caller":"traceutil/trace.go:171","msg":"trace[782424119] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"1.065784738s","start":"2026-05-21T02:56:32.098882Z","end":"2026-05-21T02:56:33.164666Z","steps":["trace[782424119] 'process raft request' (duration: 1.065449291s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:33.164861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:32.09885Z","time spent":"1.065911051s","remote":"127.0.0.1:39500","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-21T02:56:33.272952Z","caller":"traceutil/trace.go:171","msg":"trace[371720873] linearizableReadLoop","detail":"{readStateIndex:797; appliedIndex:795; }","duration":"1.12958734s","start":"2026-05-21T02:56:32.143337Z","end":"2026-05-21T02:56:33.272925Z","steps":["trace[371720873] 'read index received' (duration: 1.021048856s)","trace[371720873] 'applied index is now lower than readState.Index' (duration: 108.537524ms)"],"step_count":2} {"level":"warn","ts":"2026-05-21T02:56:33.273167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.129803534s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-21T02:56:33.273148Z","caller":"traceutil/trace.go:171","msg":"trace[1908799673] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"1.125668061s","start":"2026-05-21T02:56:32.147445Z","end":"2026-05-21T02:56:33.273113Z","steps":["trace[1908799673] 'process raft request' (duration: 1.122186541s)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:33.273225Z","caller":"traceutil/trace.go:171","msg":"trace[1333985670] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:765; }","duration":"1.129913377s","start":"2026-05-21T02:56:32.143299Z","end":"2026-05-21T02:56:33.273212Z","steps":["trace[1333985670] 'agreement among raft nodes before linearized reading' (duration: 1.129787613s)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:33.273267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:32.143284Z","time spent":"1.129974029s","remote":"127.0.0.1:39270","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-21T02:56:33.273366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.15571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-21T02:56:33.273422Z","caller":"traceutil/trace.go:171","msg":"trace[852818983] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:765; }","duration":"578.312173ms","start":"2026-05-21T02:56:32.695096Z","end":"2026-05-21T02:56:33.273408Z","steps":["trace[852818983] 'agreement among raft nodes before linearized reading' (duration: 578.073458ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:33.273462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:32.695075Z","time spent":"578.378474ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-21T02:56:33.273498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"558.566255ms","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-05-21T02:56:33.273617Z","caller":"traceutil/trace.go:171","msg":"trace[377693308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:765; }","duration":"558.715498ms","start":"2026-05-21T02:56:32.714875Z","end":"2026-05-21T02:56:33.273591Z","steps":["trace[377693308] 'agreement among raft nodes before linearized reading' (duration: 558.389212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:33.273678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:32.714864Z","time spent":"558.80094ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-21T02:56:33.27369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.706797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-21T02:56:33.273775Z","caller":"traceutil/trace.go:171","msg":"trace[1584383545] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:765; }","duration":"555.80778ms","start":"2026-05-21T02:56:32.717946Z","end":"2026-05-21T02:56:33.273754Z","steps":["trace[1584383545] 'agreement among raft nodes before linearized reading' (duration: 555.592096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:33.273825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:32.717932Z","time spent":"555.879631ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-21T02:56:33.273457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:32.147424Z","time spent":"1.125833646s","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-21T02:56:33.274003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.045657ms","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-05-21T02:56:33.274227Z","caller":"traceutil/trace.go:171","msg":"trace[1139745517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:765; }","duration":"574.305512ms","start":"2026-05-21T02:56:32.699902Z","end":"2026-05-21T02:56:33.274208Z","steps":["trace[1139745517] 'agreement among raft nodes before linearized reading' (duration: 573.595908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-21T02:56:33.274619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-21T02:56:32.699882Z","time spent":"574.715911ms","remote":"127.0.0.1:39530","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-21T02:56:36.26522Z","caller":"traceutil/trace.go:171","msg":"trace[260276638] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"160.72961ms","start":"2026-05-21T02:56:36.104466Z","end":"2026-05-21T02:56:36.265195Z","steps":["trace[260276638] 'process raft request' (duration: 160.548486ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:37.45122Z","caller":"traceutil/trace.go:171","msg":"trace[1209415313] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"116.449114ms","start":"2026-05-21T02:56:37.334724Z","end":"2026-05-21T02:56:37.451173Z","steps":["trace[1209415313] 'process raft request' (duration: 64.004665ms)","trace[1209415313] 'compare' (duration: 52.233005ms)"],"step_count":2} {"level":"info","ts":"2026-05-21T02:56:43.428565Z","caller":"traceutil/trace.go:171","msg":"trace[156001073] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"105.744623ms","start":"2026-05-21T02:56:43.322797Z","end":"2026-05-21T02:56:43.428542Z","steps":["trace[156001073] 'process raft request' (duration: 105.537729ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:43.672178Z","caller":"traceutil/trace.go:171","msg":"trace[1213633224] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"115.012759ms","start":"2026-05-21T02:56:43.55714Z","end":"2026-05-21T02:56:43.672153Z","steps":["trace[1213633224] 'process raft request' (duration: 114.157443ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:43.672442Z","caller":"traceutil/trace.go:171","msg":"trace[609500036] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"115.293614ms","start":"2026-05-21T02:56:43.557137Z","end":"2026-05-21T02:56:43.672431Z","steps":["trace[609500036] 'process raft request' (duration: 114.958108ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:43.672684Z","caller":"traceutil/trace.go:171","msg":"trace[2033363202] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"114.765825ms","start":"2026-05-21T02:56:43.557903Z","end":"2026-05-21T02:56:43.672668Z","steps":["trace[2033363202] 'process raft request' (duration: 114.681323ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:56:43.672745Z","caller":"traceutil/trace.go:171","msg":"trace[962883828] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"115.459968ms","start":"2026-05-21T02:56:43.557223Z","end":"2026-05-21T02:56:43.672683Z","steps":["trace[962883828] 'process raft request' (duration: 115.168213ms)"],"step_count":1} {"level":"info","ts":"2026-05-21T02:57:07.249439Z","caller":"traceutil/trace.go:171","msg":"trace[1879697849] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"138.408518ms","start":"2026-05-21T02:57:07.111009Z","end":"2026-05-21T02:57:07.249418Z","steps":["trace[1879697849] 'process raft request' (duration: 130.005674ms)"],"step_count":1}