{"level":"warn","ts":"2026-04-18T22:13:32.333692Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:13:32.333795Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.223: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.223:2380","--initial-cluster=instance=https://199.204.45.223:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.223:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.223:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-18T22:13:32.333892Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-18T22:13:32.333915Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-18T22:13:32.333953Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T22:13:32.335082Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"]} {"level":"info","ts":"2026-04-18T22:13:32.335253Z","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.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.223:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-18T22:13:32.34103Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.45179ms"} {"level":"info","ts":"2026-04-18T22:13:32.350705Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"11f26225a5bb9fe3","cluster-id":"75c25101f01fd4c6"} {"level":"info","ts":"2026-04-18T22:13:32.350803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T22:13:32.350836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 0"} {"level":"info","ts":"2026-04-18T22:13:32.35086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 11f26225a5bb9fe3 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T22:13:32.350878Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became follower at term 1"} {"level":"info","ts":"2026-04-18T22:13:32.350937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"warn","ts":"2026-04-18T22:13:32.365445Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T22:13:32.367664Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T22:13:32.370989Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-18T22:13:32.373269Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"11f26225a5bb9fe3","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T22:13:32.373423Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"11f26225a5bb9fe3","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T22:13:32.373557Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T22:13:32.376864Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T22:13:32.377062Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-18T22:13:32.377391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 switched to configuration voters=(1293203956842602467)"} {"level":"info","ts":"2026-04-18T22:13:32.377677Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","added-peer-id":"11f26225a5bb9fe3","added-peer-peer-urls":["https://199.204.45.223:2380"]} {"level":"info","ts":"2026-04-18T22:13:32.381281Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-18T22:13:32.381546Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"11f26225a5bb9fe3","initial-advertise-peer-urls":["https://199.204.45.223:2380"],"listen-peer-urls":["https://199.204.45.223:2380"],"advertise-client-urls":["https://199.204.45.223:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.223:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T22:13:32.38161Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T22:13:32.381708Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-18T22:13:32.38175Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.223:2380"} {"level":"info","ts":"2026-04-18T22:13:32.956439Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T22:13:32.956511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T22:13:32.956559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgPreVoteResp from 11f26225a5bb9fe3 at term 1"} {"level":"info","ts":"2026-04-18T22:13:32.956581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became candidate at term 2"} {"level":"info","ts":"2026-04-18T22:13:32.956587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 received MsgVoteResp from 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-18T22:13:32.956596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"11f26225a5bb9fe3 became leader at term 2"} {"level":"info","ts":"2026-04-18T22:13:32.956604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 11f26225a5bb9fe3 elected leader 11f26225a5bb9fe3 at term 2"} {"level":"info","ts":"2026-04-18T22:13:32.958649Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"11f26225a5bb9fe3","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.223:2379]}","request-path":"/0/members/11f26225a5bb9fe3/attributes","cluster-id":"75c25101f01fd4c6","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T22:13:32.958685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:13:32.958775Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:13:32.958856Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:13:32.959235Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T22:13:32.95926Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T22:13:32.960087Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"75c25101f01fd4c6","local-member-id":"11f26225a5bb9fe3","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:13:32.960195Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:13:32.960229Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:13:32.961907Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.223:2379"} {"level":"info","ts":"2026-04-18T22:13:32.962723Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-18T22:14:03.717792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.255119ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:14:03.717931Z","caller":"traceutil/trace.go:171","msg":"trace[855049281] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"734.54812ms","start":"2026-04-18T22:14:02.983364Z","end":"2026-04-18T22:14:03.717912Z","steps":["trace[855049281] 'process raft request' (duration: 39.594789ms)","trace[855049281] 'compare' (duration: 693.718669ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:14:03.718036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:02.983314Z","time spent":"734.662993ms","remote":"127.0.0.1:34946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:14:03.735506Z","caller":"traceutil/trace.go:171","msg":"trace[1642130285] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"680.786333ms","start":"2026-04-18T22:14:03.054694Z","end":"2026-04-18T22:14:03.735481Z","steps":["trace[1642130285] 'process raft request' (duration: 680.542439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:03.735608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:03.05466Z","time spent":"680.906956ms","remote":"127.0.0.1:34946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:14:03.735648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.331758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:03.735691Z","caller":"traceutil/trace.go:171","msg":"trace[1013253576] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:581; }","duration":"339.437579ms","start":"2026-04-18T22:14:03.396245Z","end":"2026-04-18T22:14:03.735682Z","steps":["trace[1013253576] 'agreement among raft nodes before linearized reading' (duration: 339.304356ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:14:03.735483Z","caller":"traceutil/trace.go:171","msg":"trace[1854693636] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"339.145065ms","start":"2026-04-18T22:14:03.396295Z","end":"2026-04-18T22:14:03.73544Z","steps":["trace[1854693636] 'read index received' (duration: 338.829089ms)","trace[1854693636] 'applied index is now lower than readState.Index' (duration: 314.855µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:14:03.735716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:03.396222Z","time spent":"339.48764ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:14:03.735841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.780897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-18T22:14:03.735895Z","caller":"traceutil/trace.go:171","msg":"trace[1923270945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:581; }","duration":"179.869129ms","start":"2026-04-18T22:14:03.556012Z","end":"2026-04-18T22:14:03.735881Z","steps":["trace[1923270945] 'agreement among raft nodes before linearized reading' (duration: 179.770687ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:14:08.902033Z","caller":"traceutil/trace.go:171","msg":"trace[1158373473] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"501.825891ms","start":"2026-04-18T22:14:08.400179Z","end":"2026-04-18T22:14:08.902005Z","steps":["trace[1158373473] 'read index received' (duration: 500.72983ms)","trace[1158373473] 'applied index is now lower than readState.Index' (duration: 1.094311ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:14:08.902895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.684706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:08.902979Z","caller":"traceutil/trace.go:171","msg":"trace[1675403878] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"502.872041ms","start":"2026-04-18T22:14:08.400074Z","end":"2026-04-18T22:14:08.902946Z","steps":["trace[1675403878] 'agreement among raft nodes before linearized reading' (duration: 502.038025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:08.903028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.40006Z","time spent":"502.956822ms","remote":"127.0.0.1:34884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T22:14:08.903663Z","caller":"traceutil/trace.go:171","msg":"trace[890388125] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"565.958286ms","start":"2026-04-18T22:14:08.336136Z","end":"2026-04-18T22:14:08.902095Z","steps":["trace[890388125] 'process raft request' (duration: 565.041049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:08.90419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.336115Z","time spent":"567.870371ms","remote":"127.0.0.1:35004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:14:08.909638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.565781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-18T22:14:08.909738Z","caller":"traceutil/trace.go:171","msg":"trace[450473367] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:605; }","duration":"438.675683ms","start":"2026-04-18T22:14:08.47102Z","end":"2026-04-18T22:14:08.909696Z","steps":["trace[450473367] 'agreement among raft nodes before linearized reading' (duration: 438.461609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:08.909777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.47101Z","time spent":"438.758394ms","remote":"127.0.0.1:35172","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":"info","ts":"2026-04-18T22:14:08.910094Z","caller":"traceutil/trace.go:171","msg":"trace[2043818479] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"305.043545ms","start":"2026-04-18T22:14:08.605038Z","end":"2026-04-18T22:14:08.910082Z","steps":["trace[2043818479] 'process raft request' (duration: 304.27478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:08.910179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.605012Z","time spent":"305.108555ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:14:08.910385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.562225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-18T22:14:08.910441Z","caller":"traceutil/trace.go:171","msg":"trace[1418955724] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"364.651868ms","start":"2026-04-18T22:14:08.545774Z","end":"2026-04-18T22:14:08.910426Z","steps":["trace[1418955724] 'agreement among raft nodes before linearized reading' (duration: 364.473445ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:08.910493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.545764Z","time spent":"364.710628ms","remote":"127.0.0.1:35172","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-04-18T22:14:08.910661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.554703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-18T22:14:08.910711Z","caller":"traceutil/trace.go:171","msg":"trace[1360279710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:605; }","duration":"360.606103ms","start":"2026-04-18T22:14:08.55008Z","end":"2026-04-18T22:14:08.910686Z","steps":["trace[1360279710] 'agreement among raft nodes before linearized reading' (duration: 360.508811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:08.910746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.550071Z","time spent":"360.667144ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:14:10.364172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406978153s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:14:10.364612Z","caller":"traceutil/trace.go:171","msg":"trace[1884133229] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:624; }","duration":"1.396283639s","start":"2026-04-18T22:14:08.968302Z","end":"2026-04-18T22:14:10.364586Z","steps":["trace[1884133229] 'read index received' (duration: 142.50331ms)","trace[1884133229] 'applied index is now lower than readState.Index' (duration: 1.253778549s)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:14:10.364953Z","caller":"traceutil/trace.go:171","msg":"trace[359618845] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.447882356s","start":"2026-04-18T22:14:08.917051Z","end":"2026-04-18T22:14:10.364934Z","steps":["trace[359618845] 'process raft request' (duration: 40.032918ms)","trace[359618845] 'compare' (duration: 1.406748888s)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:14:10.365075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.916982Z","time spent":"1.448045269s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:14:10.365108Z","caller":"traceutil/trace.go:171","msg":"trace[1772479702] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.434532554s","start":"2026-04-18T22:14:08.930516Z","end":"2026-04-18T22:14:10.365048Z","steps":["trace[1772479702] 'process raft request' (duration: 1.433990604s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:10.365281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.396978871s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:10.365337Z","caller":"traceutil/trace.go:171","msg":"trace[1735624357] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:609; }","duration":"1.397066473s","start":"2026-04-18T22:14:08.968249Z","end":"2026-04-18T22:14:10.365316Z","steps":["trace[1735624357] 'agreement among raft nodes before linearized reading' (duration: 1.396988351s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:10.365382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.96823Z","time spent":"1.397138964s","remote":"127.0.0.1:35116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-18T22:14:10.365382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.930498Z","time spent":"1.434732527s","remote":"127.0.0.1:35098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:14:10.365444Z","caller":"traceutil/trace.go:171","msg":"trace[749547662] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"1.447649572s","start":"2026-04-18T22:14:08.917747Z","end":"2026-04-18T22:14:10.365396Z","steps":["trace[749547662] 'process raft request' (duration: 1.446701035s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:10.365556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"969.46615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:14:10.365666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.917742Z","time spent":"1.447818365s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:14:10.365678Z","caller":"traceutil/trace.go:171","msg":"trace[660679968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"969.651904ms","start":"2026-04-18T22:14:09.395994Z","end":"2026-04-18T22:14:10.365646Z","steps":["trace[660679968] 'agreement among raft nodes before linearized reading' (duration: 969.41862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:10.365743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:09.395932Z","time spent":"969.800526ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T22:14:10.365854Z","caller":"traceutil/trace.go:171","msg":"trace[778741632] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"1.448168381s","start":"2026-04-18T22:14:08.917673Z","end":"2026-04-18T22:14:10.365842Z","steps":["trace[778741632] 'process raft request' (duration: 1.446632483s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:10.365915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:08.917648Z","time spent":"1.448234322s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:14:10.365916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.270462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-18T22:14:10.365967Z","caller":"traceutil/trace.go:171","msg":"trace[1788880906] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:609; }","duration":"582.367245ms","start":"2026-04-18T22:14:09.783583Z","end":"2026-04-18T22:14:10.36595Z","steps":["trace[1788880906] 'agreement among raft nodes before linearized reading' (duration: 582.179831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:10.366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:09.783559Z","time spent":"582.434006ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:14:11.146095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.622344ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.146226Z","caller":"traceutil/trace.go:171","msg":"trace[1713908824] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:609; }","duration":"158.766456ms","start":"2026-04-18T22:14:10.98744Z","end":"2026-04-18T22:14:11.146207Z","steps":["trace[1713908824] 'range keys from in-memory index tree' (duration: 158.608984ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:14:11.147272Z","caller":"traceutil/trace.go:171","msg":"trace[362808128] linearizableReadLoop","detail":"{readStateIndex:629; appliedIndex:628; }","duration":"397.897793ms","start":"2026-04-18T22:14:10.74936Z","end":"2026-04-18T22:14:11.147258Z","steps":["trace[362808128] 'read index received' (duration: 390.870445ms)","trace[362808128] 'applied index is now lower than readState.Index' (duration: 7.026468ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:14:11.147538Z","caller":"traceutil/trace.go:171","msg":"trace[665565432] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"772.635914ms","start":"2026-04-18T22:14:10.374844Z","end":"2026-04-18T22:14:11.147479Z","steps":["trace[665565432] 'process raft request' (duration: 765.376142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.147746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.374817Z","time spent":"772.828246ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:14:11.147969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.604215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.148011Z","caller":"traceutil/trace.go:171","msg":"trace[708592348] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:610; }","duration":"398.644896ms","start":"2026-04-18T22:14:10.749353Z","end":"2026-04-18T22:14:11.147998Z","steps":["trace[708592348] 'agreement among raft nodes before linearized reading' (duration: 398.581434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.148045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.749344Z","time spent":"398.692707ms","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:14:11.169919Z","caller":"traceutil/trace.go:171","msg":"trace[1465336692] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"404.517433ms","start":"2026-04-18T22:14:10.76537Z","end":"2026-04-18T22:14:11.169888Z","steps":["trace[1465336692] 'process raft request' (duration: 402.914624ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.170025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.865561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.170117Z","caller":"traceutil/trace.go:171","msg":"trace[1983386974] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:611; }","duration":"282.990773ms","start":"2026-04-18T22:14:10.887108Z","end":"2026-04-18T22:14:11.170099Z","steps":["trace[1983386974] 'agreement among raft nodes before linearized reading' (duration: 282.8192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.170219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.765344Z","time spent":"404.707106ms","remote":"127.0.0.1:35004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036109,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:14:11.170277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.724087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.170336Z","caller":"traceutil/trace.go:171","msg":"trace[1726101578] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:611; }","duration":"283.812008ms","start":"2026-04-18T22:14:10.886511Z","end":"2026-04-18T22:14:11.170323Z","steps":["trace[1726101578] 'agreement among raft nodes before linearized reading' (duration: 283.721867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.1704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.574597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.170446Z","caller":"traceutil/trace.go:171","msg":"trace[466384260] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:611; }","duration":"259.704189ms","start":"2026-04-18T22:14:10.910729Z","end":"2026-04-18T22:14:11.170433Z","steps":["trace[466384260] 'agreement among raft nodes before linearized reading' (duration: 259.638528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.170585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.044693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:14:11.170582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.454315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:14:11.170705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.989578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.170737Z","caller":"traceutil/trace.go:171","msg":"trace[1312991533] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:611; }","duration":"379.032288ms","start":"2026-04-18T22:14:10.791696Z","end":"2026-04-18T22:14:11.170728Z","steps":["trace[1312991533] 'agreement among raft nodes before linearized reading' (duration: 378.991338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.170767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.791674Z","time spent":"379.084509ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-04-18T22:14:11.170744Z","caller":"traceutil/trace.go:171","msg":"trace[368991150] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:611; }","duration":"259.654678ms","start":"2026-04-18T22:14:10.911068Z","end":"2026-04-18T22:14:11.170723Z","steps":["trace[368991150] 'agreement among raft nodes before linearized reading' (duration: 259.1782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.170971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.906986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.171028Z","caller":"traceutil/trace.go:171","msg":"trace[274854452] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:611; }","duration":"175.974968ms","start":"2026-04-18T22:14:10.995037Z","end":"2026-04-18T22:14:11.171012Z","steps":["trace[274854452] 'agreement among raft nodes before linearized reading' (duration: 175.897936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.171085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.116909ms","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-04-18T22:14:11.171131Z","caller":"traceutil/trace.go:171","msg":"trace[353899654] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:611; }","duration":"177.177981ms","start":"2026-04-18T22:14:10.993939Z","end":"2026-04-18T22:14:11.171117Z","steps":["trace[353899654] 'agreement among raft nodes before linearized reading' (duration: 177.10509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.171351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.850301ms","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-04-18T22:14:11.171396Z","caller":"traceutil/trace.go:171","msg":"trace[1586359904] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:611; }","duration":"216.918993ms","start":"2026-04-18T22:14:10.954467Z","end":"2026-04-18T22:14:11.171386Z","steps":["trace[1586359904] 'agreement among raft nodes before linearized reading' (duration: 216.840662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.171546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.142327ms","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-04-18T22:14:11.171576Z","caller":"traceutil/trace.go:171","msg":"trace[348154411] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:611; }","duration":"217.215128ms","start":"2026-04-18T22:14:10.954352Z","end":"2026-04-18T22:14:11.171567Z","steps":["trace[348154411] 'agreement among raft nodes before linearized reading' (duration: 217.170617ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:14:11.170627Z","caller":"traceutil/trace.go:171","msg":"trace[332406078] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:611; }","duration":"284.102543ms","start":"2026-04-18T22:14:10.886513Z","end":"2026-04-18T22:14:11.170616Z","steps":["trace[332406078] 'agreement among raft nodes before linearized reading' (duration: 284.033582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.170641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.877493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.171953Z","caller":"traceutil/trace.go:171","msg":"trace[1685688735] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:611; }","duration":"261.231708ms","start":"2026-04-18T22:14:10.910703Z","end":"2026-04-18T22:14:11.171935Z","steps":["trace[1685688735] 'agreement among raft nodes before linearized reading' (duration: 259.904743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.170041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.982069ms","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":"warn","ts":"2026-04-18T22:14:11.17206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.944049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.172091Z","caller":"traceutil/trace.go:171","msg":"trace[1550824981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:611; }","duration":"178.073856ms","start":"2026-04-18T22:14:10.994004Z","end":"2026-04-18T22:14:11.172078Z","steps":["trace[1550824981] 'agreement among raft nodes before linearized reading' (duration: 175.982998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.172139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.458384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.172173Z","caller":"traceutil/trace.go:171","msg":"trace[335732351] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:611; }","duration":"380.518066ms","start":"2026-04-18T22:14:10.791647Z","end":"2026-04-18T22:14:11.172165Z","steps":["trace[335732351] 'agreement among raft nodes before linearized reading' (duration: 380.473735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.172207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.791635Z","time spent":"380.563596ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:14:11.17067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.295615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.172279Z","caller":"traceutil/trace.go:171","msg":"trace[637186113] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:611; }","duration":"379.945255ms","start":"2026-04-18T22:14:10.792322Z","end":"2026-04-18T22:14:11.172267Z","steps":["trace[637186113] 'agreement among raft nodes before linearized reading' (duration: 378.326596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.172323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.792304Z","time spent":"380.002116ms","remote":"127.0.0.1:56226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:14:11.172335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.438438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.172364Z","caller":"traceutil/trace.go:171","msg":"trace[1197508898] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:611; }","duration":"394.483759ms","start":"2026-04-18T22:14:10.777872Z","end":"2026-04-18T22:14:11.172355Z","steps":["trace[1197508898] 'agreement among raft nodes before linearized reading' (duration: 394.437348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.172434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.777862Z","time spent":"394.559772ms","remote":"127.0.0.1:56210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"info","ts":"2026-04-18T22:14:11.172101Z","caller":"traceutil/trace.go:171","msg":"trace[1357737376] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:611; }","duration":"395.02182ms","start":"2026-04-18T22:14:10.777066Z","end":"2026-04-18T22:14:11.172088Z","steps":["trace[1357737376] 'agreement among raft nodes before linearized reading' (duration: 394.961089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.172483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.777048Z","time spent":"395.424138ms","remote":"127.0.0.1:56210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:14:11.172743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.691612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.17278Z","caller":"traceutil/trace.go:171","msg":"trace[1520659651] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:611; }","duration":"395.754963ms","start":"2026-04-18T22:14:10.777016Z","end":"2026-04-18T22:14:11.172771Z","steps":["trace[1520659651] 'agreement among raft nodes before linearized reading' (duration: 395.695272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.172811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.777006Z","time spent":"395.797735ms","remote":"127.0.0.1:56210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:14:11.172978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.714214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.173027Z","caller":"traceutil/trace.go:171","msg":"trace[1936082191] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:611; }","duration":"422.806645ms","start":"2026-04-18T22:14:10.750205Z","end":"2026-04-18T22:14:11.173012Z","steps":["trace[1936082191] 'agreement among raft nodes before linearized reading' (duration: 422.733274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.173064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.75018Z","time spent":"422.875506ms","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:14:11.173963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.562307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:11.17403Z","caller":"traceutil/trace.go:171","msg":"trace[1227202896] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:611; }","duration":"424.66973ms","start":"2026-04-18T22:14:10.749338Z","end":"2026-04-18T22:14:11.174008Z","steps":["trace[1227202896] 'agreement among raft nodes before linearized reading' (duration: 421.516132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:11.174067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:10.749313Z","time spent":"424.743361ms","remote":"127.0.0.1:56198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-18T22:14:12.286336Z","caller":"traceutil/trace.go:171","msg":"trace[135794070] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"108.3869ms","start":"2026-04-18T22:14:12.177903Z","end":"2026-04-18T22:14:12.28629Z","steps":["trace[135794070] 'process raft request' (duration: 107.571195ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:14:16.30719Z","caller":"traceutil/trace.go:171","msg":"trace[538234164] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"223.106734ms","start":"2026-04-18T22:14:16.084055Z","end":"2026-04-18T22:14:16.307162Z","steps":["trace[538234164] 'process raft request' (duration: 222.83043ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:14:16.312872Z","caller":"traceutil/trace.go:171","msg":"trace[159842634] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"151.28074ms","start":"2026-04-18T22:14:16.161559Z","end":"2026-04-18T22:14:16.31284Z","steps":["trace[159842634] 'process raft request' (duration: 151.025815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:27.27796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.372031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-btdwz\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-18T22:14:27.278215Z","caller":"traceutil/trace.go:171","msg":"trace[1986676849] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-btdwz; range_end:; response_count:1; response_revision:788; }","duration":"277.695288ms","start":"2026-04-18T22:14:27.000489Z","end":"2026-04-18T22:14:27.278184Z","steps":["trace[1986676849] 'range keys from in-memory index tree' (duration: 277.138627ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:14:27.686819Z","caller":"traceutil/trace.go:171","msg":"trace[217807097] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"402.953114ms","start":"2026-04-18T22:14:27.283817Z","end":"2026-04-18T22:14:27.68677Z","steps":["trace[217807097] 'process raft request' (duration: 402.74407ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:27.687033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:27.28379Z","time spent":"403.138237ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:14:28.191328Z","caller":"traceutil/trace.go:171","msg":"trace[443056765] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"795.737925ms","start":"2026-04-18T22:14:27.395566Z","end":"2026-04-18T22:14:28.191303Z","steps":["trace[443056765] 'read index received' (duration: 291.205284ms)","trace[443056765] 'applied index is now lower than readState.Index' (duration: 504.530801ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:14:28.191484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"795.904027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:14:28.191526Z","caller":"traceutil/trace.go:171","msg":"trace[1714587257] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:790; }","duration":"795.995439ms","start":"2026-04-18T22:14:27.395518Z","end":"2026-04-18T22:14:28.191514Z","steps":["trace[1714587257] 'agreement among raft nodes before linearized reading' (duration: 795.887748ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:28.191565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:27.395506Z","time spent":"796.05131ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T22:14:28.191682Z","caller":"traceutil/trace.go:171","msg":"trace[396932841] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"903.334179ms","start":"2026-04-18T22:14:27.28831Z","end":"2026-04-18T22:14:28.191645Z","steps":["trace[396932841] 'process raft request' (duration: 902.85569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:14:28.191892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:14:27.288285Z","time spent":"903.489352ms","remote":"127.0.0.1:35098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:15:03.50578Z","caller":"traceutil/trace.go:171","msg":"trace[273493392] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1037; }","duration":"111.280209ms","start":"2026-04-18T22:15:03.394478Z","end":"2026-04-18T22:15:03.505758Z","steps":["trace[273493392] 'read index received' (duration: 111.005024ms)","trace[273493392] 'applied index is now lower than readState.Index' (duration: 273.975µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:15:03.50596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.472932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:15:03.505927Z","caller":"traceutil/trace.go:171","msg":"trace[310501647] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"190.200743ms","start":"2026-04-18T22:15:03.315659Z","end":"2026-04-18T22:15:03.50586Z","steps":["trace[310501647] 'process raft request' (duration: 189.932118ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:03.506011Z","caller":"traceutil/trace.go:171","msg":"trace[482352411] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1005; }","duration":"111.584375ms","start":"2026-04-18T22:15:03.394412Z","end":"2026-04-18T22:15:03.505997Z","steps":["trace[482352411] 'agreement among raft nodes before linearized reading' (duration: 111.444252ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:29.830279Z","caller":"traceutil/trace.go:171","msg":"trace[795118406] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"223.613266ms","start":"2026-04-18T22:15:29.60663Z","end":"2026-04-18T22:15:29.830244Z","steps":["trace[795118406] 'process raft request' (duration: 223.388212ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:30.896963Z","caller":"traceutil/trace.go:171","msg":"trace[338102672] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"239.767059ms","start":"2026-04-18T22:15:30.657145Z","end":"2026-04-18T22:15:30.896912Z","steps":["trace[338102672] 'process raft request' (duration: 239.546255ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:31.013247Z","caller":"traceutil/trace.go:171","msg":"trace[398065297] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"111.593134ms","start":"2026-04-18T22:15:30.901627Z","end":"2026-04-18T22:15:31.01322Z","steps":["trace[398065297] 'process raft request' (duration: 98.037271ms)","trace[398065297] 'compare' (duration: 13.427911ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:15:31.060076Z","caller":"traceutil/trace.go:171","msg":"trace[1776099315] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1131; }","duration":"112.041543ms","start":"2026-04-18T22:15:30.948017Z","end":"2026-04-18T22:15:31.060058Z","steps":["trace[1776099315] 'read index received' (duration: 51.659806ms)","trace[1776099315] 'applied index is now lower than readState.Index' (duration: 60.380277ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:15:31.060191Z","caller":"traceutil/trace.go:171","msg":"trace[1818559236] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"152.764193ms","start":"2026-04-18T22:15:30.90741Z","end":"2026-04-18T22:15:31.060174Z","steps":["trace[1818559236] 'process raft request' (duration: 152.6081ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:31.060332Z","caller":"traceutil/trace.go:171","msg":"trace[1787464372] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"157.39844ms","start":"2026-04-18T22:15:30.902768Z","end":"2026-04-18T22:15:31.060166Z","steps":["trace[1787464372] 'process raft request' (duration: 157.174466ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:15:31.060478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.42369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:15:31.060553Z","caller":"traceutil/trace.go:171","msg":"trace[271421762] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1096; }","duration":"112.528952ms","start":"2026-04-18T22:15:30.948008Z","end":"2026-04-18T22:15:31.060536Z","steps":["trace[271421762] 'agreement among raft nodes before linearized reading' (duration: 112.315958ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:32.244809Z","caller":"traceutil/trace.go:171","msg":"trace[124584729] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"107.03659ms","start":"2026-04-18T22:15:32.13773Z","end":"2026-04-18T22:15:32.244767Z","steps":["trace[124584729] 'process raft request' (duration: 106.866937ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:44.563878Z","caller":"traceutil/trace.go:171","msg":"trace[1683928157] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"168.63417ms","start":"2026-04-18T22:15:44.395218Z","end":"2026-04-18T22:15:44.563852Z","steps":["trace[1683928157] 'read index received' (duration: 168.422006ms)","trace[1683928157] 'applied index is now lower than readState.Index' (duration: 211.364µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:15:44.564046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.799273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:15:44.564074Z","caller":"traceutil/trace.go:171","msg":"trace[1515310262] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1190; }","duration":"168.859375ms","start":"2026-04-18T22:15:44.395206Z","end":"2026-04-18T22:15:44.564066Z","steps":["trace[1515310262] 'agreement among raft nodes before linearized reading' (duration: 168.750902ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:15:44.564441Z","caller":"traceutil/trace.go:171","msg":"trace[1515593644] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"250.416998ms","start":"2026-04-18T22:15:44.314018Z","end":"2026-04-18T22:15:44.564435Z","steps":["trace[1515593644] 'process raft request' (duration: 249.692114ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:00.541386Z","caller":"traceutil/trace.go:171","msg":"trace[1353221276] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"132.037127ms","start":"2026-04-18T22:16:00.409318Z","end":"2026-04-18T22:16:00.541355Z","steps":["trace[1353221276] 'process raft request' (duration: 131.881934ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:01.686618Z","caller":"traceutil/trace.go:171","msg":"trace[28052936] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"444.156147ms","start":"2026-04-18T22:16:01.242434Z","end":"2026-04-18T22:16:01.68659Z","steps":["trace[28052936] 'process raft request' (duration: 443.772989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:01.686819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:01.242409Z","time spent":"444.296879ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:02.758835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:02.442795Z","time spent":"316.012687ms","remote":"127.0.0.1:41138","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-18T22:16:02.759051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.474314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:16:02.759183Z","caller":"traceutil/trace.go:171","msg":"trace[1543137336] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1310; }","duration":"1.513156022s","start":"2026-04-18T22:16:01.246006Z","end":"2026-04-18T22:16:02.759162Z","steps":["trace[1543137336] 'read index received' (duration: 440.399668ms)","trace[1543137336] 'applied index is now lower than readState.Index' (duration: 1.072754774s)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:02.759417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.513408846s","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-04-18T22:16:02.759461Z","caller":"traceutil/trace.go:171","msg":"trace[1735817802] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1265; }","duration":"1.513505288s","start":"2026-04-18T22:16:01.245944Z","end":"2026-04-18T22:16:02.759449Z","steps":["trace[1735817802] 'agreement among raft nodes before linearized reading' (duration: 1.513335385s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:02.759498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:01.245915Z","time spent":"1.51357392s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-18T22:16:02.759399Z","caller":"traceutil/trace.go:171","msg":"trace[1162004454] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"1.515065727s","start":"2026-04-18T22:16:01.244208Z","end":"2026-04-18T22:16:02.759274Z","steps":["trace[1162004454] 'process raft request' (duration: 1.097260807s)","trace[1162004454] 'compare' (duration: 417.088496ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:02.759809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:01.244196Z","time spent":"1.515434174s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:02.798481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.103253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-18T22:16:02.798535Z","caller":"traceutil/trace.go:171","msg":"trace[95233522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1267; }","duration":"146.193646ms","start":"2026-04-18T22:16:02.652326Z","end":"2026-04-18T22:16:02.79852Z","steps":["trace[95233522] 'agreement among raft nodes before linearized reading' (duration: 146.032953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:02.798537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.398808284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:02.798559Z","caller":"traceutil/trace.go:171","msg":"trace[267557552] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"1.106744299s","start":"2026-04-18T22:16:01.691787Z","end":"2026-04-18T22:16:02.798532Z","steps":["trace[267557552] 'process raft request' (duration: 1.106380363s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:02.798579Z","caller":"traceutil/trace.go:171","msg":"trace[271741683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"1.398873806s","start":"2026-04-18T22:16:01.399687Z","end":"2026-04-18T22:16:02.798561Z","steps":["trace[271741683] 'agreement among raft nodes before linearized reading' (duration: 1.398827805s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:02.798586Z","caller":"traceutil/trace.go:171","msg":"trace[983440904] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"685.416809ms","start":"2026-04-18T22:16:02.113134Z","end":"2026-04-18T22:16:02.798551Z","steps":["trace[983440904] 'process raft request' (duration: 685.146144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:02.79862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:01.399667Z","time spent":"1.398946247s","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:16:02.798587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.036908564s","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":"warn","ts":"2026-04-18T22:16:02.798481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.546455453s","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-04-18T22:16:02.798684Z","caller":"traceutil/trace.go:171","msg":"trace[1746379770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1267; }","duration":"1.546681577s","start":"2026-04-18T22:16:01.251995Z","end":"2026-04-18T22:16:02.798676Z","steps":["trace[1746379770] 'agreement among raft nodes before linearized reading' (duration: 1.546347311s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:02.798691Z","caller":"traceutil/trace.go:171","msg":"trace[1817720576] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1267; }","duration":"1.037077628s","start":"2026-04-18T22:16:01.761586Z","end":"2026-04-18T22:16:02.798664Z","steps":["trace[1817720576] 'agreement among raft nodes before linearized reading' (duration: 1.036847944s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:02.798697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:01.691755Z","time spent":"1.106856281s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:02.798708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:02.113107Z","time spent":"685.537591ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:02.798752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:01.761568Z","time spent":"1.037172449s","remote":"127.0.0.1:56250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:16:02.798707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:01.251986Z","time spent":"1.546714028s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T22:16:03.875171Z","caller":"traceutil/trace.go:171","msg":"trace[43474391] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1323; }","duration":"182.968771ms","start":"2026-04-18T22:16:03.692167Z","end":"2026-04-18T22:16:03.875136Z","steps":["trace[43474391] 'read index received' (duration: 182.664516ms)","trace[43474391] 'applied index is now lower than readState.Index' (duration: 302.875µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:03.87532Z","caller":"traceutil/trace.go:171","msg":"trace[1616613273] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"373.085848ms","start":"2026-04-18T22:16:03.502184Z","end":"2026-04-18T22:16:03.875269Z","steps":["trace[1616613273] 'process raft request' (duration: 372.752372ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:03.875569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.366868ms","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-04-18T22:16:03.875669Z","caller":"traceutil/trace.go:171","msg":"trace[19748638] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1277; }","duration":"183.551772ms","start":"2026-04-18T22:16:03.692095Z","end":"2026-04-18T22:16:03.875646Z","steps":["trace[19748638] 'agreement among raft nodes before linearized reading' (duration: 183.194545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:03.875698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:03.502154Z","time spent":"373.281741ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:04.508787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.329133ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:16:04.508875Z","caller":"traceutil/trace.go:171","msg":"trace[1663468514] linearizableReadLoop","detail":"{readStateIndex:1325; appliedIndex:1324; }","duration":"116.249779ms","start":"2026-04-18T22:16:04.392611Z","end":"2026-04-18T22:16:04.50886Z","steps":["trace[1663468514] 'read index received' (duration: 40.691µs)","trace[1663468514] 'applied index is now lower than readState.Index' (duration: 116.207948ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:04.508924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.318861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:04.508937Z","caller":"traceutil/trace.go:171","msg":"trace[219575496] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1278; }","duration":"116.375442ms","start":"2026-04-18T22:16:04.392556Z","end":"2026-04-18T22:16:04.508932Z","steps":["trace[219575496] 'agreement among raft nodes before linearized reading' (duration: 116.33952ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:04.509116Z","caller":"traceutil/trace.go:171","msg":"trace[373140175] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"627.789085ms","start":"2026-04-18T22:16:03.881264Z","end":"2026-04-18T22:16:04.509054Z","steps":["trace[373140175] 'process raft request' (duration: 357.121105ms)","trace[373140175] 'compare' (duration: 270.201401ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:04.509323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:03.881236Z","time spent":"627.954708ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:16:04.980606Z","caller":"traceutil/trace.go:171","msg":"trace[809939927] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"107.706757ms","start":"2026-04-18T22:16:04.872861Z","end":"2026-04-18T22:16:04.980567Z","steps":["trace[809939927] 'process raft request' (duration: 107.469793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:06.455714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.325465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-18T22:16:06.455787Z","caller":"traceutil/trace.go:171","msg":"trace[1186907318] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1284; }","duration":"259.433006ms","start":"2026-04-18T22:16:06.196339Z","end":"2026-04-18T22:16:06.455772Z","steps":["trace[1186907318] 'range keys from in-memory index tree' (duration: 259.197482ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:07.163603Z","caller":"traceutil/trace.go:171","msg":"trace[454484465] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1335; }","duration":"200.514293ms","start":"2026-04-18T22:16:06.963065Z","end":"2026-04-18T22:16:07.163579Z","steps":["trace[454484465] 'read index received' (duration: 144.053075ms)","trace[454484465] 'applied index is now lower than readState.Index' (duration: 56.460128ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:07.163875Z","caller":"traceutil/trace.go:171","msg":"trace[1960665304] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"258.399068ms","start":"2026-04-18T22:16:06.905461Z","end":"2026-04-18T22:16:07.16386Z","steps":["trace[1960665304] 'process raft request' (duration: 201.717306ms)","trace[1960665304] 'compare' (duration: 56.266754ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:07.164196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.108354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-18T22:16:07.16423Z","caller":"traceutil/trace.go:171","msg":"trace[485740571] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1288; }","duration":"201.183416ms","start":"2026-04-18T22:16:06.963037Z","end":"2026-04-18T22:16:07.16422Z","steps":["trace[485740571] 'agreement among raft nodes before linearized reading' (duration: 201.022563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:07.164424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.838991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-18T22:16:07.164504Z","caller":"traceutil/trace.go:171","msg":"trace[516403391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1288; }","duration":"179.987514ms","start":"2026-04-18T22:16:06.984497Z","end":"2026-04-18T22:16:07.164485Z","steps":["trace[516403391] 'agreement among raft nodes before linearized reading' (duration: 179.702329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:17.215989Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225593672715143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T22:16:17.716823Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11521225593672715143,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T22:16:18.052341Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.452775469s","expected-duration":"1s"} {"level":"info","ts":"2026-04-18T22:16:18.052824Z","caller":"traceutil/trace.go:171","msg":"trace[2060363471] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"1.45335235s","start":"2026-04-18T22:16:16.599439Z","end":"2026-04-18T22:16:18.052791Z","steps":["trace[2060363471] 'process raft request' (duration: 1.453168777s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.052994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:16.599414Z","time spent":"1.453463822s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:16:18.055881Z","caller":"traceutil/trace.go:171","msg":"trace[1524863527] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1408; }","duration":"1.339909924s","start":"2026-04-18T22:16:16.715946Z","end":"2026-04-18T22:16:18.055856Z","steps":["trace[1524863527] 'read index received' (duration: 1.33701758s)","trace[1524863527] 'applied index is now lower than readState.Index' (duration: 2.890524ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:18.055985Z","caller":"traceutil/trace.go:171","msg":"trace[1429101277] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"433.209694ms","start":"2026-04-18T22:16:17.622715Z","end":"2026-04-18T22:16:18.055925Z","steps":["trace[1429101277] 'process raft request' (duration: 433.075461ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:18.055981Z","caller":"traceutil/trace.go:171","msg":"trace[1282881071] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"1.123443119s","start":"2026-04-18T22:16:16.932475Z","end":"2026-04-18T22:16:18.055918Z","steps":["trace[1282881071] 'process raft request' (duration: 1.123195805s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.056211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:16.932418Z","time spent":"1.123662213s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:18.056193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.34021471s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:16:18.056356Z","caller":"traceutil/trace.go:171","msg":"trace[1819320785] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1360; }","duration":"1.340419684s","start":"2026-04-18T22:16:16.715916Z","end":"2026-04-18T22:16:18.056335Z","steps":["trace[1819320785] 'agreement among raft nodes before linearized reading' (duration: 1.34017934s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.056505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:16.715897Z","time spent":"1.340592037s","remote":"127.0.0.1:35008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:16:18.056269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:17.62269Z","time spent":"433.354437ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:18.057247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.309956748s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-18T22:16:18.057347Z","caller":"traceutil/trace.go:171","msg":"trace[605127043] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1360; }","duration":"1.31007949s","start":"2026-04-18T22:16:16.747252Z","end":"2026-04-18T22:16:18.057331Z","steps":["trace[605127043] 'agreement among raft nodes before linearized reading' (duration: 1.309888827s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.057428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:16.747224Z","time spent":"1.310192593s","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-18T22:16:18.057692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.917556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-04-18T22:16:18.057707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.967254ms","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-04-18T22:16:18.057756Z","caller":"traceutil/trace.go:171","msg":"trace[1906150695] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1360; }","duration":"186.036839ms","start":"2026-04-18T22:16:17.871707Z","end":"2026-04-18T22:16:18.057744Z","steps":["trace[1906150695] 'agreement among raft nodes before linearized reading' (duration: 185.832345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.057714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.48137ms","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-04-18T22:16:18.057899Z","caller":"traceutil/trace.go:171","msg":"trace[1960710759] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1360; }","duration":"838.718454ms","start":"2026-04-18T22:16:17.219172Z","end":"2026-04-18T22:16:18.057891Z","steps":["trace[1960710759] 'agreement among raft nodes before linearized reading' (duration: 838.46262ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.057926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:17.219141Z","time spent":"838.775745ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-18T22:16:18.057977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.143330776s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-18T22:16:18.058078Z","caller":"traceutil/trace.go:171","msg":"trace[2025800133] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1360; }","duration":"1.143559621s","start":"2026-04-18T22:16:16.914505Z","end":"2026-04-18T22:16:18.058065Z","steps":["trace[2025800133] 'agreement among raft nodes before linearized reading' (duration: 1.143295835s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.05816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:16.914495Z","time spent":"1.143654472s","remote":"127.0.0.1:35172","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-04-18T22:16:18.058223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.303352433s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:16:18.058259Z","caller":"traceutil/trace.go:171","msg":"trace[1405013283] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1360; }","duration":"1.303443375s","start":"2026-04-18T22:16:16.754804Z","end":"2026-04-18T22:16:18.058247Z","steps":["trace[1405013283] 'agreement among raft nodes before linearized reading' (duration: 1.303380714s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.058284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:16.754776Z","time spent":"1.303502055s","remote":"127.0.0.1:48572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":29,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:16:18.057773Z","caller":"traceutil/trace.go:171","msg":"trace[418769793] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1360; }","duration":"825.037425ms","start":"2026-04-18T22:16:17.232716Z","end":"2026-04-18T22:16:18.057754Z","steps":["trace[418769793] 'agreement among raft nodes before linearized reading' (duration: 824.542196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.058479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:17.232621Z","time spent":"825.850871ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:16:18.058465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.234911ms","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-04-18T22:16:18.058572Z","caller":"traceutil/trace.go:171","msg":"trace[2049934454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1360; }","duration":"824.341622ms","start":"2026-04-18T22:16:17.234213Z","end":"2026-04-18T22:16:18.058555Z","steps":["trace[2049934454] 'agreement among raft nodes before linearized reading' (duration: 824.022637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.058642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:17.234174Z","time spent":"824.454115ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:16:18.059399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.808277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:18.059698Z","caller":"traceutil/trace.go:171","msg":"trace[977550445] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1360; }","duration":"432.400809ms","start":"2026-04-18T22:16:17.627271Z","end":"2026-04-18T22:16:18.059672Z","steps":["trace[977550445] 'agreement among raft nodes before linearized reading' (duration: 430.226107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:18.059757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:17.627238Z","time spent":"432.507201ms","remote":"127.0.0.1:34888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:16:56.491422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.803389ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:16:56.491541Z","caller":"traceutil/trace.go:171","msg":"trace[371815168] linearizableReadLoop","detail":"{readStateIndex:1593; appliedIndex:1592; }","duration":"315.564029ms","start":"2026-04-18T22:16:56.175962Z","end":"2026-04-18T22:16:56.491526Z","steps":["trace[371815168] 'read index received' (duration: 38.641µs)","trace[371815168] 'applied index is now lower than readState.Index' (duration: 315.523408ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:56.491627Z","caller":"traceutil/trace.go:171","msg":"trace[390012387] transaction","detail":"{read_only:false; response_revision:1535; number_of_response:1; }","duration":"462.12382ms","start":"2026-04-18T22:16:56.029441Z","end":"2026-04-18T22:16:56.491565Z","steps":["trace[390012387] 'process raft request' (duration: 96.091427ms)","trace[390012387] 'compare' (duration: 365.399662ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:16:56.491837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:56.029421Z","time spent":"462.297285ms","remote":"127.0.0.1:34928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:16:56.491672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.710202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:16:56.492139Z","caller":"traceutil/trace.go:171","msg":"trace[1876031319] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1535; }","duration":"316.212581ms","start":"2026-04-18T22:16:56.175903Z","end":"2026-04-18T22:16:56.492116Z","steps":["trace[1876031319] 'agreement among raft nodes before linearized reading' (duration: 315.692811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:56.492195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:56.175872Z","time spent":"316.306893ms","remote":"127.0.0.1:35132","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:16:56.569586Z","caller":"traceutil/trace.go:171","msg":"trace[88560598] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"370.56119ms","start":"2026-04-18T22:16:56.198981Z","end":"2026-04-18T22:16:56.569542Z","steps":["trace[88560598] 'process raft request' (duration: 370.302525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:56.56965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.168836ms","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-04-18T22:16:56.569697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.352773ms","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-04-18T22:16:56.569773Z","caller":"traceutil/trace.go:171","msg":"trace[1689394282] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1536; }","duration":"344.457426ms","start":"2026-04-18T22:16:56.225297Z","end":"2026-04-18T22:16:56.569755Z","steps":["trace[1689394282] 'agreement among raft nodes before linearized reading' (duration: 344.196841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:56.56976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.471906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-18T22:16:56.569813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:56.198956Z","time spent":"370.745573ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:16:56.569722Z","caller":"traceutil/trace.go:171","msg":"trace[1389728420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1536; }","duration":"301.274539ms","start":"2026-04-18T22:16:56.268428Z","end":"2026-04-18T22:16:56.569703Z","steps":["trace[1389728420] 'agreement among raft nodes before linearized reading' (duration: 301.049625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:56.569868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:56.268417Z","time spent":"301.444432ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-18T22:16:56.569859Z","caller":"traceutil/trace.go:171","msg":"trace[1136893145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1536; }","duration":"297.607938ms","start":"2026-04-18T22:16:56.272229Z","end":"2026-04-18T22:16:56.569837Z","steps":["trace[1136893145] 'agreement among raft nodes before linearized reading' (duration: 297.240781ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:56.569933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.765526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:16:56.569828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:56.225284Z","time spent":"344.533447ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-18T22:16:56.570013Z","caller":"traceutil/trace.go:171","msg":"trace[324895035] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1536; }","duration":"173.900029ms","start":"2026-04-18T22:16:56.396092Z","end":"2026-04-18T22:16:56.569992Z","steps":["trace[324895035] 'agreement among raft nodes before linearized reading' (duration: 173.725536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:56.570096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.776414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-18T22:16:56.570119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.270563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"warn","ts":"2026-04-18T22:16:56.570108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.762133ms","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-04-18T22:16:56.570154Z","caller":"traceutil/trace.go:171","msg":"trace[1838172382] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1536; }","duration":"297.325175ms","start":"2026-04-18T22:16:56.27282Z","end":"2026-04-18T22:16:56.570145Z","steps":["trace[1838172382] 'agreement among raft nodes before linearized reading' (duration: 297.226802ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:56.570169Z","caller":"traceutil/trace.go:171","msg":"trace[1071750607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1536; }","duration":"334.839864ms","start":"2026-04-18T22:16:56.235314Z","end":"2026-04-18T22:16:56.570154Z","steps":["trace[1071750607] 'agreement among raft nodes before linearized reading' (duration: 334.722131ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:56.570166Z","caller":"traceutil/trace.go:171","msg":"trace[625617681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1536; }","duration":"333.844055ms","start":"2026-04-18T22:16:56.236301Z","end":"2026-04-18T22:16:56.570145Z","steps":["trace[625617681] 'agreement among raft nodes before linearized reading' (duration: 333.6546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:16:56.570217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:56.235303Z","time spent":"334.887295ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:16:56.570227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:16:56.236267Z","time spent":"333.951217ms","remote":"127.0.0.1:35172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-18T22:16:56.761562Z","caller":"traceutil/trace.go:171","msg":"trace[1950429926] transaction","detail":"{read_only:false; response_revision:1537; number_of_response:1; }","duration":"185.726152ms","start":"2026-04-18T22:16:56.575792Z","end":"2026-04-18T22:16:56.761519Z","steps":["trace[1950429926] 'process raft request' (duration: 154.176386ms)","trace[1950429926] 'compare' (duration: 31.367113ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:16:56.766884Z","caller":"traceutil/trace.go:171","msg":"trace[360914] transaction","detail":"{read_only:false; response_revision:1539; number_of_response:1; }","duration":"189.990334ms","start":"2026-04-18T22:16:56.576849Z","end":"2026-04-18T22:16:56.766839Z","steps":["trace[360914] 'process raft request' (duration: 189.885982ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:56.766919Z","caller":"traceutil/trace.go:171","msg":"trace[2139151660] transaction","detail":"{read_only:false; response_revision:1538; number_of_response:1; }","duration":"190.078895ms","start":"2026-04-18T22:16:56.5768Z","end":"2026-04-18T22:16:56.766879Z","steps":["trace[2139151660] 'process raft request' (duration: 189.77497ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:56.767151Z","caller":"traceutil/trace.go:171","msg":"trace[1793051692] transaction","detail":"{read_only:false; response_revision:1540; number_of_response:1; }","duration":"190.252299ms","start":"2026-04-18T22:16:56.576877Z","end":"2026-04-18T22:16:56.767129Z","steps":["trace[1793051692] 'process raft request' (duration: 189.903013ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:56.767214Z","caller":"traceutil/trace.go:171","msg":"trace[1539460536] transaction","detail":"{read_only:false; response_revision:1542; number_of_response:1; }","duration":"190.274989ms","start":"2026-04-18T22:16:56.576924Z","end":"2026-04-18T22:16:56.767199Z","steps":["trace[1539460536] 'process raft request' (duration: 190.177417ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:16:56.767213Z","caller":"traceutil/trace.go:171","msg":"trace[2069037557] transaction","detail":"{read_only:false; response_revision:1541; number_of_response:1; }","duration":"190.280559ms","start":"2026-04-18T22:16:56.576916Z","end":"2026-04-18T22:16:56.767197Z","steps":["trace[2069037557] 'process raft request' (duration: 190.093666ms)"],"step_count":1}