{"level":"warn","ts":"2026-04-18T22:17:06.644873Z","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:17:06.644949Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.35: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.35:2380","--initial-cluster=instance=https://199.204.45.35:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.35:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.35: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:17:06.645028Z","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:17:06.645039Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-18T22:17:06.645057Z","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:17:06.645678Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"]} {"level":"info","ts":"2026-04-18T22:17:06.645757Z","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.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.35: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:17:06.650998Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.050068ms"} {"level":"info","ts":"2026-04-18T22:17:06.659893Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fb85913747d92cac","cluster-id":"636a84d5a3ba9c31"} {"level":"info","ts":"2026-04-18T22:17:06.659965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=()"} {"level":"info","ts":"2026-04-18T22:17:06.659988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 0"} {"level":"info","ts":"2026-04-18T22:17:06.659998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fb85913747d92cac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-18T22:17:06.660012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became follower at term 1"} {"level":"info","ts":"2026-04-18T22:17:06.66005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"warn","ts":"2026-04-18T22:17:06.668367Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-18T22:17:06.671609Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-18T22:17:06.673229Z","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:17:06.676465Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fb85913747d92cac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-18T22:17:06.676748Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fb85913747d92cac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-18T22:17:06.676771Z","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:17:06.677332Z","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:17:06.677352Z","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:17:06.680581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac switched to configuration voters=(18124051942037073068)"} {"level":"info","ts":"2026-04-18T22:17:06.680773Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","added-peer-id":"fb85913747d92cac","added-peer-peer-urls":["https://199.204.45.35:2380"]} {"level":"info","ts":"2026-04-18T22:17:06.681712Z","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:17:06.681821Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-18T22:17:06.681864Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.35:2380"} {"level":"info","ts":"2026-04-18T22:17:06.681995Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fb85913747d92cac","initial-advertise-peer-urls":["https://199.204.45.35:2380"],"listen-peer-urls":["https://199.204.45.35:2380"],"advertise-client-urls":["https://199.204.45.35:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.35:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-18T22:17:06.682043Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-18T22:17:07.361074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac is starting a new election at term 1"} {"level":"info","ts":"2026-04-18T22:17:07.361148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became pre-candidate at term 1"} {"level":"info","ts":"2026-04-18T22:17:07.361185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgPreVoteResp from fb85913747d92cac at term 1"} {"level":"info","ts":"2026-04-18T22:17:07.361207Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became candidate at term 2"} {"level":"info","ts":"2026-04-18T22:17:07.361218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac received MsgVoteResp from fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-18T22:17:07.361236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fb85913747d92cac became leader at term 2"} {"level":"info","ts":"2026-04-18T22:17:07.361259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fb85913747d92cac elected leader fb85913747d92cac at term 2"} {"level":"info","ts":"2026-04-18T22:17:07.362479Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:17:07.363538Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:17:07.363538Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fb85913747d92cac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.35:2379]}","request-path":"/0/members/fb85913747d92cac/attributes","cluster-id":"636a84d5a3ba9c31","publish-timeout":"7s"} {"level":"info","ts":"2026-04-18T22:17:07.363642Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-18T22:17:07.364373Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"636a84d5a3ba9c31","local-member-id":"fb85913747d92cac","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:17:07.364498Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:17:07.36454Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-18T22:17:07.364581Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-18T22:17:07.3646Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-18T22:17:07.366479Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-18T22:17:07.367456Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.35:2379"} {"level":"info","ts":"2026-04-18T22:17:08.866018Z","caller":"traceutil/trace.go:171","msg":"trace[1929489798] linearizableReadLoop","detail":"{readStateIndex:5; appliedIndex:4; }","duration":"181.598245ms","start":"2026-04-18T22:17:08.684353Z","end":"2026-04-18T22:17:08.865951Z","steps":["trace[1929489798] 'read index received' (duration: 180.781785ms)","trace[1929489798] 'applied index is now lower than readState.Index' (duration: 815.08µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:08.866211Z","caller":"traceutil/trace.go:171","msg":"trace[884084422] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"184.291868ms","start":"2026-04-18T22:17:08.681903Z","end":"2026-04-18T22:17:08.866195Z","steps":["trace[884084422] 'process raft request' (duration: 182.540176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:08.867293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.903935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T22:17:08.867549Z","caller":"traceutil/trace.go:171","msg":"trace[492050182] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:0; response_revision:2; }","duration":"183.07715ms","start":"2026-04-18T22:17:08.684342Z","end":"2026-04-18T22:17:08.867419Z","steps":["trace[492050182] 'agreement among raft nodes before linearized reading' (duration: 182.054996ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344336Z","caller":"traceutil/trace.go:171","msg":"trace[489928480] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"593.209001ms","start":"2026-04-18T22:17:08.751082Z","end":"2026-04-18T22:17:09.344291Z","steps":["trace[489928480] 'process raft request' (duration: 592.873504ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344392Z","caller":"traceutil/trace.go:171","msg":"trace[91502779] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"592.505535ms","start":"2026-04-18T22:17:08.751826Z","end":"2026-04-18T22:17:09.344331Z","steps":["trace[91502779] 'process raft request' (duration: 592.401833ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344529Z","caller":"traceutil/trace.go:171","msg":"trace[1972829029] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"592.971825ms","start":"2026-04-18T22:17:08.75154Z","end":"2026-04-18T22:17:09.344512Z","steps":["trace[1972829029] 'process raft request' (duration: 592.662708ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344518Z","caller":"traceutil/trace.go:171","msg":"trace[2088846976] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"593.052347ms","start":"2026-04-18T22:17:08.751371Z","end":"2026-04-18T22:17:09.344424Z","steps":["trace[2088846976] 'process raft request' (duration: 592.805062ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344617Z","caller":"traceutil/trace.go:171","msg":"trace[1006200819] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"592.744321ms","start":"2026-04-18T22:17:08.751863Z","end":"2026-04-18T22:17:09.344607Z","steps":["trace[1006200819] 'process raft request' (duration: 592.387942ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344636Z","caller":"traceutil/trace.go:171","msg":"trace[575343177] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"566.458169ms","start":"2026-04-18T22:17:08.778133Z","end":"2026-04-18T22:17:09.344591Z","steps":["trace[575343177] 'process raft request' (duration: 566.246924ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344686Z","caller":"traceutil/trace.go:171","msg":"trace[1011838125] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"561.476873ms","start":"2026-04-18T22:17:08.783201Z","end":"2026-04-18T22:17:09.344678Z","steps":["trace[1011838125] 'process raft request' (duration: 561.210547ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.344621Z","caller":"traceutil/trace.go:171","msg":"trace[869089289] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:5; }","duration":"478.448521ms","start":"2026-04-18T22:17:08.8661Z","end":"2026-04-18T22:17:09.344548Z","steps":["trace[869089289] 'read index received' (duration: 477.855798ms)","trace[869089289] 'applied index is now lower than readState.Index' (duration: 591.603µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:17:09.344799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.8154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-18T22:17:09.344794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.18137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T22:17:09.344834Z","caller":"traceutil/trace.go:171","msg":"trace[750082322] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:10; }","duration":"591.886472ms","start":"2026-04-18T22:17:08.752936Z","end":"2026-04-18T22:17:09.344823Z","steps":["trace[750082322] 'agreement among raft nodes before linearized reading' (duration: 591.797529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.344818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.820262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T22:17:09.344843Z","caller":"traceutil/trace.go:171","msg":"trace[1986325966] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"510.243442ms","start":"2026-04-18T22:17:08.834586Z","end":"2026-04-18T22:17:09.34483Z","steps":["trace[1986325966] 'agreement among raft nodes before linearized reading' (duration: 509.994455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.344857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.752924Z","time spent":"591.926772ms","remote":"127.0.0.1:44858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-04-18T22:17:09.344882Z","caller":"traceutil/trace.go:171","msg":"trace[1876994127] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"506.929254ms","start":"2026-04-18T22:17:08.837928Z","end":"2026-04-18T22:17:09.344857Z","steps":["trace[1876994127] 'agreement among raft nodes before linearized reading' (duration: 506.814342ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.34489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.834574Z","time spent":"510.308614ms","remote":"127.0.0.1:44876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-18T22:17:09.344903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.378897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-18T22:17:09.34492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.837918Z","time spent":"506.993616ms","remote":"127.0.0.1:44876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-18T22:17:09.34494Z","caller":"traceutil/trace.go:171","msg":"trace[585676526] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:10; }","duration":"520.447179ms","start":"2026-04-18T22:17:08.824481Z","end":"2026-04-18T22:17:09.344929Z","steps":["trace[585676526] 'agreement among raft nodes before linearized reading' (duration: 520.373597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.344974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.824461Z","time spent":"520.506051ms","remote":"127.0.0.1:44876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-04-18T22:17:09.345006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T22:17:09.345026Z","caller":"traceutil/trace.go:171","msg":"trace[627588184] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"539.84283ms","start":"2026-04-18T22:17:08.805177Z","end":"2026-04-18T22:17:09.345019Z","steps":["trace[627588184] 'agreement among raft nodes before linearized reading' (duration: 539.811449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.345049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.805163Z","time spent":"539.882322ms","remote":"127.0.0.1:44876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-18T22:17:09.34499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"648.783865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-18T22:17:09.345139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.124187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T22:17:09.345163Z","caller":"traceutil/trace.go:171","msg":"trace[1579606795] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"595.181978ms","start":"2026-04-18T22:17:08.749975Z","end":"2026-04-18T22:17:09.345157Z","steps":["trace[1579606795] 'agreement among raft nodes before linearized reading' (duration: 595.152537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.34518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.749952Z","time spent":"595.223989ms","remote":"127.0.0.1:44876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-18T22:17:09.345176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.090666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T22:17:09.345133Z","caller":"traceutil/trace.go:171","msg":"trace[855960200] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:10; }","duration":"649.109473ms","start":"2026-04-18T22:17:08.696008Z","end":"2026-04-18T22:17:09.345118Z","steps":["trace[855960200] 'agreement among raft nodes before linearized reading' (duration: 648.763505ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:09.345209Z","caller":"traceutil/trace.go:171","msg":"trace[1277683] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:0; response_revision:10; }","duration":"595.133787ms","start":"2026-04-18T22:17:08.750066Z","end":"2026-04-18T22:17:09.3452Z","steps":["trace[1277683] 'agreement among raft nodes before linearized reading' (duration: 595.080186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.345246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.750063Z","time spent":"595.177848ms","remote":"127.0.0.1:44818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.35\" "} {"level":"warn","ts":"2026-04-18T22:17:09.345251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.696002Z","time spent":"649.238926ms","remote":"127.0.0.1:45152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-04-18T22:17:09.345325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"607.789941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-18T22:17:09.345384Z","caller":"traceutil/trace.go:171","msg":"trace[2114176266] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:10; }","duration":"607.892043ms","start":"2026-04-18T22:17:08.737482Z","end":"2026-04-18T22:17:09.345375Z","steps":["trace[2114176266] 'agreement among raft nodes before linearized reading' (duration: 607.74498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.34546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.73745Z","time spent":"607.998416ms","remote":"127.0.0.1:44876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-18T22:17:09.345653Z","caller":"traceutil/trace.go:171","msg":"trace[1779916879] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"594.329008ms","start":"2026-04-18T22:17:08.751255Z","end":"2026-04-18T22:17:09.345584Z","steps":["trace[1779916879] 'process raft request' (duration: 592.866623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.346019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.783189Z","time spent":"561.517225ms","remote":"127.0.0.1:45028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:09.346306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.778119Z","time spent":"566.587113ms","remote":"127.0.0.1:44960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:09.346826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.751058Z","time spent":"593.387615ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:09.346941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.751792Z","time spent":"592.687219ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:09.346963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.751241Z","time spent":"594.470821ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:09.347417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.751506Z","time spent":"593.057638ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:09.347492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.751351Z","time spent":"593.230791ms","remote":"127.0.0.1:45260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:09.347607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.751851Z","time spent":"592.807792ms","remote":"127.0.0.1:45206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-18T22:17:09.348964Z","caller":"traceutil/trace.go:171","msg":"trace[1675365499] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"479.6973ms","start":"2026-04-18T22:17:08.869257Z","end":"2026-04-18T22:17:09.348954Z","steps":["trace[1675365499] 'process raft request' (duration: 479.657049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:09.349279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:08.869092Z","time spent":"479.932366ms","remote":"127.0.0.1:44846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:36.138336Z","caller":"traceutil/trace.go:171","msg":"trace[470768431] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"139.109776ms","start":"2026-04-18T22:17:35.99919Z","end":"2026-04-18T22:17:36.1383Z","steps":["trace[470768431] 'process raft request' (duration: 138.909971ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.228985Z","caller":"traceutil/trace.go:171","msg":"trace[1821697527] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"218.979134ms","start":"2026-04-18T22:17:36.009942Z","end":"2026-04-18T22:17:36.228921Z","steps":["trace[1821697527] 'process raft request' (duration: 218.029623ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229015Z","caller":"traceutil/trace.go:171","msg":"trace[704161868] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"210.917309ms","start":"2026-04-18T22:17:36.018043Z","end":"2026-04-18T22:17:36.22896Z","steps":["trace[704161868] 'process raft request' (duration: 210.735985ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229351Z","caller":"traceutil/trace.go:171","msg":"trace[1210504310] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"192.798114ms","start":"2026-04-18T22:17:36.036531Z","end":"2026-04-18T22:17:36.229329Z","steps":["trace[1210504310] 'process raft request' (duration: 192.387504ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229424Z","caller":"traceutil/trace.go:171","msg":"trace[964609923] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"187.654247ms","start":"2026-04-18T22:17:36.041725Z","end":"2026-04-18T22:17:36.229379Z","steps":["trace[964609923] 'process raft request' (duration: 187.267628ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229424Z","caller":"traceutil/trace.go:171","msg":"trace[1427840748] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"155.411638ms","start":"2026-04-18T22:17:36.073993Z","end":"2026-04-18T22:17:36.229404Z","steps":["trace[1427840748] 'process raft request' (duration: 155.343197ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229493Z","caller":"traceutil/trace.go:171","msg":"trace[2111344518] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"193.121352ms","start":"2026-04-18T22:17:36.036362Z","end":"2026-04-18T22:17:36.229484Z","steps":["trace[2111344518] 'process raft request' (duration: 192.504817ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229589Z","caller":"traceutil/trace.go:171","msg":"trace[2124511746] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"187.946465ms","start":"2026-04-18T22:17:36.041632Z","end":"2026-04-18T22:17:36.229578Z","steps":["trace[2124511746] 'process raft request' (duration: 187.32322ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.22967Z","caller":"traceutil/trace.go:171","msg":"trace[713042948] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"174.107178ms","start":"2026-04-18T22:17:36.055553Z","end":"2026-04-18T22:17:36.22966Z","steps":["trace[713042948] 'process raft request' (duration: 173.659897ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229661Z","caller":"traceutil/trace.go:171","msg":"trace[2046394972] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"183.750308ms","start":"2026-04-18T22:17:36.045898Z","end":"2026-04-18T22:17:36.229648Z","steps":["trace[2046394972] 'process raft request' (duration: 183.144303ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:36.229458Z","caller":"traceutil/trace.go:171","msg":"trace[1480127398] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"193.163352ms","start":"2026-04-18T22:17:36.036281Z","end":"2026-04-18T22:17:36.229445Z","steps":["trace[1480127398] 'process raft request' (duration: 192.542778ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:37.586532Z","caller":"traceutil/trace.go:171","msg":"trace[1057764482] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"428.346469ms","start":"2026-04-18T22:17:37.158148Z","end":"2026-04-18T22:17:37.586494Z","steps":["trace[1057764482] 'process raft request' (duration: 427.788067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:37.586783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:37.158127Z","time spent":"428.531914ms","remote":"127.0.0.1:44832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:37.632496Z","caller":"traceutil/trace.go:171","msg":"trace[745853494] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"227.05683ms","start":"2026-04-18T22:17:37.405405Z","end":"2026-04-18T22:17:37.632462Z","steps":["trace[745853494] 'read index received' (duration: 180.459633ms)","trace[745853494] 'applied index is now lower than readState.Index' (duration: 46.595997ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:17:37.632765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.259344ms","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:17:37.632743Z","caller":"traceutil/trace.go:171","msg":"trace[1268469302] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"386.769978ms","start":"2026-04-18T22:17:37.245923Z","end":"2026-04-18T22:17:37.632693Z","steps":["trace[1268469302] 'process raft request' (duration: 384.22297ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:37.632806Z","caller":"traceutil/trace.go:171","msg":"trace[1032320225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:576; }","duration":"227.430738ms","start":"2026-04-18T22:17:37.405363Z","end":"2026-04-18T22:17:37.632794Z","steps":["trace[1032320225] 'agreement among raft nodes before linearized reading' (duration: 227.217664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:37.63291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:37.245893Z","time spent":"386.919191ms","remote":"127.0.0.1:44832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:17:42.033824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.642388ms","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:17:42.033917Z","caller":"traceutil/trace.go:171","msg":"trace[1927534096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:601; }","duration":"370.778641ms","start":"2026-04-18T22:17:41.663113Z","end":"2026-04-18T22:17:42.033892Z","steps":["trace[1927534096] 'range keys from in-memory index tree' (duration: 370.480105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:42.033963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:41.663093Z","time spent":"370.860574ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T22:17:42.042896Z","caller":"traceutil/trace.go:171","msg":"trace[231009122] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"341.774207ms","start":"2026-04-18T22:17:41.701078Z","end":"2026-04-18T22:17:42.042852Z","steps":["trace[231009122] 'process raft request' (duration: 333.897047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:42.046294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:41.701033Z","time spent":"345.108933ms","remote":"127.0.0.1:44864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:17:44.959715Z","caller":"traceutil/trace.go:171","msg":"trace[223339286] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"155.793378ms","start":"2026-04-18T22:17:44.80381Z","end":"2026-04-18T22:17:44.959603Z","steps":["trace[223339286] 'read index received' (duration: 155.522002ms)","trace[223339286] 'applied index is now lower than readState.Index' (duration: 270.276µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:44.959747Z","caller":"traceutil/trace.go:171","msg":"trace[277040407] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"183.594624ms","start":"2026-04-18T22:17:44.776128Z","end":"2026-04-18T22:17:44.959723Z","steps":["trace[277040407] 'process raft request' (duration: 183.301028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:44.960032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.037344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:44.960197Z","caller":"traceutil/trace.go:171","msg":"trace[2028638364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"156.353571ms","start":"2026-04-18T22:17:44.803747Z","end":"2026-04-18T22:17:44.9601Z","steps":["trace[2028638364] 'agreement among raft nodes before linearized reading' (duration: 156.053034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.848901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.863245ms","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:17:45.848934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.25043ms","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:17:45.848993Z","caller":"traceutil/trace.go:171","msg":"trace[1095370216] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:626; }","duration":"361.048198ms","start":"2026-04-18T22:17:45.487921Z","end":"2026-04-18T22:17:45.848969Z","steps":["trace[1095370216] 'range keys from in-memory index tree' (duration: 360.618578ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:45.84902Z","caller":"traceutil/trace.go:171","msg":"trace[13649780] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:626; }","duration":"360.389883ms","start":"2026-04-18T22:17:45.488607Z","end":"2026-04-18T22:17:45.848997Z","steps":["trace[13649780] 'range keys from in-memory index tree' (duration: 360.134537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.487848Z","time spent":"361.186472ms","remote":"127.0.0.1:55998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:45.849071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.488587Z","time spent":"360.472484ms","remote":"127.0.0.1:55998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:17:45.849268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.281321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.84934Z","caller":"traceutil/trace.go:171","msg":"trace[212403651] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"298.373912ms","start":"2026-04-18T22:17:45.550945Z","end":"2026-04-18T22:17:45.849319Z","steps":["trace[212403651] 'range keys from in-memory index tree' (duration: 298.195868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.766549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.849472Z","caller":"traceutil/trace.go:171","msg":"trace[1703509692] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"193.81453ms","start":"2026-04-18T22:17:45.655647Z","end":"2026-04-18T22:17:45.849462Z","steps":["trace[1703509692] 'count revisions from in-memory index tree' (duration: 193.741768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.451105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-18T22:17:45.849572Z","caller":"traceutil/trace.go:171","msg":"trace[630360624] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:626; }","duration":"653.524727ms","start":"2026-04-18T22:17:45.196037Z","end":"2026-04-18T22:17:45.849562Z","steps":["trace[630360624] 'range keys from in-memory index tree' (duration: 653.280462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.316417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.849601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.196019Z","time spent":"653.574579ms","remote":"127.0.0.1:45036","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:17:45.849649Z","caller":"traceutil/trace.go:171","msg":"trace[1004087239] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"320.368018ms","start":"2026-04-18T22:17:45.529238Z","end":"2026-04-18T22:17:45.849606Z","steps":["trace[1004087239] 'range keys from in-memory index tree' (duration: 320.269036ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.074024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.849709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.904742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.849726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.783533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.849736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.305803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.849772Z","caller":"traceutil/trace.go:171","msg":"trace[186708009] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"321.303949ms","start":"2026-04-18T22:17:45.528433Z","end":"2026-04-18T22:17:45.849737Z","steps":["trace[186708009] 'count revisions from in-memory index tree' (duration: 321.000452ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:45.84983Z","caller":"traceutil/trace.go:171","msg":"trace[769352054] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"264.386725ms","start":"2026-04-18T22:17:45.585408Z","end":"2026-04-18T22:17:45.849795Z","steps":["trace[769352054] 'count revisions from in-memory index tree' (duration: 264.269833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.528422Z","time spent":"321.411381ms","remote":"127.0.0.1:56002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:45.849856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.327737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.849898Z","caller":"traceutil/trace.go:171","msg":"trace[768880639] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"565.399299ms","start":"2026-04-18T22:17:45.284484Z","end":"2026-04-18T22:17:45.849883Z","steps":["trace[768880639] 'range keys from in-memory index tree' (duration: 565.268496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.84992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.844173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.849933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.284466Z","time spent":"565.45489ms","remote":"127.0.0.1:55980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-18T22:17:45.849958Z","caller":"traceutil/trace.go:171","msg":"trace[1136871831] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"263.895764ms","start":"2026-04-18T22:17:45.586053Z","end":"2026-04-18T22:17:45.849949Z","steps":["trace[1136871831] 'range keys from in-memory index tree' (duration: 263.816352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.693963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.850078Z","caller":"traceutil/trace.go:171","msg":"trace[324758685] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:626; }","duration":"264.755674ms","start":"2026-04-18T22:17:45.585314Z","end":"2026-04-18T22:17:45.85007Z","steps":["trace[324758685] 'range keys from in-memory index tree' (duration: 264.56949ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.411759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.84974Z","caller":"traceutil/trace.go:171","msg":"trace[1587612703] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"193.942553ms","start":"2026-04-18T22:17:45.655789Z","end":"2026-04-18T22:17:45.849732Z","steps":["trace[1587612703] 'range keys from in-memory index tree' (duration: 193.886371ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:45.850112Z","caller":"traceutil/trace.go:171","msg":"trace[1455137578] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"565.45227ms","start":"2026-04-18T22:17:45.28465Z","end":"2026-04-18T22:17:45.850102Z","steps":["trace[1455137578] 'count revisions from in-memory index tree' (duration: 565.381818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.055345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.85015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.284645Z","time spent":"565.490351ms","remote":"127.0.0.1:55980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:17:45.850187Z","caller":"traceutil/trace.go:171","msg":"trace[326642326] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:626; }","duration":"194.566397ms","start":"2026-04-18T22:17:45.655605Z","end":"2026-04-18T22:17:45.850172Z","steps":["trace[326642326] 'range keys from in-memory index tree' (duration: 193.965763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.169066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.850302Z","caller":"traceutil/trace.go:171","msg":"trace[1052172569] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"535.215707ms","start":"2026-04-18T22:17:45.315076Z","end":"2026-04-18T22:17:45.850292Z","steps":["trace[1052172569] 'count revisions from in-memory index tree' (duration: 535.129865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.018324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.850331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.315069Z","time spent":"535.252818ms","remote":"127.0.0.1:55986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:17:45.850352Z","caller":"traceutil/trace.go:171","msg":"trace[1108983743] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:626; }","duration":"322.079006ms","start":"2026-04-18T22:17:45.528262Z","end":"2026-04-18T22:17:45.850341Z","steps":["trace[1108983743] 'range keys from in-memory index tree' (duration: 321.966443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.528248Z","time spent":"322.133507ms","remote":"127.0.0.1:56002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:45.850401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.562028ms","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:17:45.850435Z","caller":"traceutil/trace.go:171","msg":"trace[1542991302] 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:626; }","duration":"450.609559ms","start":"2026-04-18T22:17:45.399814Z","end":"2026-04-18T22:17:45.850423Z","steps":["trace[1542991302] 'range keys from in-memory index tree' (duration: 450.530937ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.092947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.850493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.60705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.850525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.399807Z","time spent":"450.6489ms","remote":"127.0.0.1:55996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"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:17:45.850532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.429229ms","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:17:45.850547Z","caller":"traceutil/trace.go:171","msg":"trace[2122666126] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"299.115001ms","start":"2026-04-18T22:17:45.551419Z","end":"2026-04-18T22:17:45.850534Z","steps":["trace[2122666126] 'range keys from in-memory index tree' (duration: 298.030156ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:45.85055Z","caller":"traceutil/trace.go:171","msg":"trace[123405721] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"502.708513ms","start":"2026-04-18T22:17:45.347829Z","end":"2026-04-18T22:17:45.850538Z","steps":["trace[123405721] 'range keys from in-memory index tree' (duration: 502.476167ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:45.850575Z","caller":"traceutil/trace.go:171","msg":"trace[998188665] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:626; }","duration":"362.525522ms","start":"2026-04-18T22:17:45.488037Z","end":"2026-04-18T22:17:45.850563Z","steps":["trace[998188665] 'count revisions from in-memory index tree' (duration: 362.306217ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.347797Z","time spent":"502.781025ms","remote":"127.0.0.1:55990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:45.850705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.313117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.849755Z","caller":"traceutil/trace.go:171","msg":"trace[1325891727] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:626; }","duration":"298.836724ms","start":"2026-04-18T22:17:45.550909Z","end":"2026-04-18T22:17:45.849746Z","steps":["trace[1325891727] 'count revisions from in-memory index tree' (duration: 298.703481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.488007Z","time spent":"362.597264ms","remote":"127.0.0.1:55998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:17:45.850738Z","caller":"traceutil/trace.go:171","msg":"trace[1549768002] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"472.345248ms","start":"2026-04-18T22:17:45.378383Z","end":"2026-04-18T22:17:45.850728Z","steps":["trace[1549768002] 'range keys from in-memory index tree' (duration: 472.264826ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.378373Z","time spent":"472.388249ms","remote":"127.0.0.1:55992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:45.850791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.622676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.850826Z","caller":"traceutil/trace.go:171","msg":"trace[1421466149] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"535.669087ms","start":"2026-04-18T22:17:45.315144Z","end":"2026-04-18T22:17:45.850813Z","steps":["trace[1421466149] 'range keys from in-memory index tree' (duration: 535.594516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.315031Z","time spent":"535.822801ms","remote":"127.0.0.1:55986","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:45.85091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.317097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.85094Z","caller":"traceutil/trace.go:171","msg":"trace[854271413] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"472.367349ms","start":"2026-04-18T22:17:45.378563Z","end":"2026-04-18T22:17:45.85093Z","steps":["trace[854271413] 'count revisions from in-memory index tree' (duration: 472.285876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.850969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.378558Z","time spent":"472.402829ms","remote":"127.0.0.1:55992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:45.850996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.009873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.85101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.282516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:45.851016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.681033ms","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:17:45.851037Z","caller":"traceutil/trace.go:171","msg":"trace[2084388824] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:626; }","duration":"535.094015ms","start":"2026-04-18T22:17:45.315933Z","end":"2026-04-18T22:17:45.851027Z","steps":["trace[2084388824] 'range keys from in-memory index tree' (duration: 534.946811ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.849688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.52923Z","time spent":"320.444969ms","remote":"127.0.0.1:56002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":115,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-18T22:17:45.851059Z","caller":"traceutil/trace.go:171","msg":"trace[1166149154] 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:626; }","duration":"451.737885ms","start":"2026-04-18T22:17:45.399308Z","end":"2026-04-18T22:17:45.851046Z","steps":["trace[1166149154] 'range keys from in-memory index tree' (duration: 451.598142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.851093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.3993Z","time spent":"451.782696ms","remote":"127.0.0.1:55996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:45.851178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.315913Z","time spent":"535.253328ms","remote":"127.0.0.1:55980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:17:45.851296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.919569ms","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":"warn","ts":"2026-04-18T22:17:45.851302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.121312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:45.851331Z","caller":"traceutil/trace.go:171","msg":"trace[1674246003] 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:626; }","duration":"451.95979ms","start":"2026-04-18T22:17:45.399358Z","end":"2026-04-18T22:17:45.851318Z","steps":["trace[1674246003] 'count revisions from in-memory index tree' (duration: 451.894669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.851378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.399354Z","time spent":"452.013821ms","remote":"127.0.0.1:55996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"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:17:45.851339Z","caller":"traceutil/trace.go:171","msg":"trace[837032929] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"472.169203ms","start":"2026-04-18T22:17:45.379159Z","end":"2026-04-18T22:17:45.851329Z","steps":["trace[837032929] 'range keys from in-memory index tree' (duration: 472.088711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.851487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.379154Z","time spent":"472.322506ms","remote":"127.0.0.1:55992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"info","ts":"2026-04-18T22:17:45.851043Z","caller":"traceutil/trace.go:171","msg":"trace[1502741158] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:626; }","duration":"503.335797ms","start":"2026-04-18T22:17:45.347696Z","end":"2026-04-18T22:17:45.851032Z","steps":["trace[1502741158] 'count revisions from in-memory index tree' (duration: 503.234655ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:45.856468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.347687Z","time spent":"508.747482ms","remote":"127.0.0.1:55990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:46.229912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.357519ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-18T22:17:46.230071Z","caller":"traceutil/trace.go:171","msg":"trace[1227489442] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"508.898044ms","start":"2026-04-18T22:17:45.72116Z","end":"2026-04-18T22:17:46.230058Z","steps":["trace[1227489442] 'read index received' (duration: 63.248658ms)","trace[1227489442] 'applied index is now lower than readState.Index' (duration: 445.648636ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:17:46.230448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.275383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.230473Z","caller":"traceutil/trace.go:171","msg":"trace[646103356] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:626; }","duration":"509.324634ms","start":"2026-04-18T22:17:45.721143Z","end":"2026-04-18T22:17:46.230468Z","steps":["trace[646103356] 'agreement among raft nodes before linearized reading' (duration: 509.277433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.230493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.721132Z","time spent":"509.355375ms","remote":"127.0.0.1:56044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-18T22:17:46.230854Z","caller":"traceutil/trace.go:171","msg":"trace[1809235860] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"371.355044ms","start":"2026-04-18T22:17:45.859494Z","end":"2026-04-18T22:17:46.230849Z","steps":["trace[1809235860] 'process raft request' (duration: 370.503854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.230941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.859471Z","time spent":"371.398916ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:17:46.24574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.379169ms","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:17:46.245811Z","caller":"traceutil/trace.go:171","msg":"trace[767114308] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"207.485151ms","start":"2026-04-18T22:17:46.038309Z","end":"2026-04-18T22:17:46.245794Z","steps":["trace[767114308] 'agreement among raft nodes before linearized reading' (duration: 197.238106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.245972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.254536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.246021Z","caller":"traceutil/trace.go:171","msg":"trace[1707784868] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"331.305817ms","start":"2026-04-18T22:17:45.914689Z","end":"2026-04-18T22:17:46.245995Z","steps":["trace[1707784868] 'agreement among raft nodes before linearized reading' (duration: 316.492588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.638173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.246085Z","caller":"traceutil/trace.go:171","msg":"trace[1008312858] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"348.659174ms","start":"2026-04-18T22:17:45.897422Z","end":"2026-04-18T22:17:46.246081Z","steps":["trace[1008312858] 'agreement among raft nodes before linearized reading' (duration: 333.767543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.2461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.897407Z","time spent":"348.688595ms","remote":"127.0.0.1:56058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:17:46.246104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.165046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:46.24601Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.626755ms","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:17:46.246175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.411759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:46.246187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.174664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.246194Z","caller":"traceutil/trace.go:171","msg":"trace[548787454] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"331.46057ms","start":"2026-04-18T22:17:45.914729Z","end":"2026-04-18T22:17:46.24619Z","steps":["trace[548787454] 'agreement among raft nodes before linearized reading' (duration: 316.445527ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:46.246201Z","caller":"traceutil/trace.go:171","msg":"trace[1203625657] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"262.207384ms","start":"2026-04-18T22:17:45.98399Z","end":"2026-04-18T22:17:46.246197Z","steps":["trace[1203625657] 'agreement among raft nodes before linearized reading' (duration: 247.233432ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.861049ms","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:17:46.246248Z","caller":"traceutil/trace.go:171","msg":"trace[1222610917] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"166.854831ms","start":"2026-04-18T22:17:46.079316Z","end":"2026-04-18T22:17:46.246171Z","steps":["trace[1222610917] 'agreement among raft nodes before linearized reading' (duration: 151.816867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.914722Z","time spent":"331.488942ms","remote":"127.0.0.1:56060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:46.246206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.682466ms","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:17:46.246233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.147915ms","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":"warn","ts":"2026-04-18T22:17:46.246343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.862478ms","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:17:46.246327Z","caller":"traceutil/trace.go:171","msg":"trace[1846469195] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"207.901531ms","start":"2026-04-18T22:17:46.03841Z","end":"2026-04-18T22:17:46.246311Z","steps":["trace[1846469195] 'agreement among raft nodes before linearized reading' (duration: 192.733044ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:46.246365Z","caller":"traceutil/trace.go:171","msg":"trace[401073546] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"317.89415ms","start":"2026-04-18T22:17:45.928466Z","end":"2026-04-18T22:17:46.24636Z","steps":["trace[401073546] 'agreement among raft nodes before linearized reading' (duration: 302.833926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.92846Z","time spent":"317.91796ms","remote":"127.0.0.1:56066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"info","ts":"2026-04-18T22:17:46.246389Z","caller":"traceutil/trace.go:171","msg":"trace[1126754381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"318.364581ms","start":"2026-04-18T22:17:45.927979Z","end":"2026-04-18T22:17:46.246343Z","steps":["trace[1126754381] 'agreement among raft nodes before linearized reading' (duration: 303.113452ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.24646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.927975Z","time spent":"318.475793ms","remote":"127.0.0.1:56066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"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:17:46.246528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.615907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:46.246534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"524.670235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.246552Z","caller":"traceutil/trace.go:171","msg":"trace[967275167] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"349.672978ms","start":"2026-04-18T22:17:45.896873Z","end":"2026-04-18T22:17:46.246546Z","steps":["trace[967275167] 'agreement among raft nodes before linearized reading' (duration: 334.249076ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:46.246555Z","caller":"traceutil/trace.go:171","msg":"trace[754557918] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"524.707056ms","start":"2026-04-18T22:17:45.721843Z","end":"2026-04-18T22:17:46.24655Z","steps":["trace[754557918] 'agreement among raft nodes before linearized reading' (duration: 509.285374ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.89686Z","time spent":"349.703888ms","remote":"127.0.0.1:56058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:46.246572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.721838Z","time spent":"524.729487ms","remote":"127.0.0.1:56044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:17:46.246063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.914677Z","time spent":"331.377769ms","remote":"127.0.0.1:56060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"info","ts":"2026-04-18T22:17:46.246121Z","caller":"traceutil/trace.go:171","msg":"trace[310688380] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:627; }","duration":"349.189367ms","start":"2026-04-18T22:17:45.896927Z","end":"2026-04-18T22:17:46.246116Z","steps":["trace[310688380] 'agreement among raft nodes before linearized reading' (duration: 334.184984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.896922Z","time spent":"349.727709ms","remote":"127.0.0.1:56058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:46.246699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.729618ms","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":"warn","ts":"2026-04-18T22:17:46.246294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.004379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:17:46.246656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.556118ms","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:17:46.246731Z","caller":"traceutil/trace.go:171","msg":"trace[421936675] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:627; }","duration":"318.772679ms","start":"2026-04-18T22:17:45.927951Z","end":"2026-04-18T22:17:46.246723Z","steps":["trace[421936675] 'agreement among raft nodes before linearized reading' (duration: 303.188733ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:46.246741Z","caller":"traceutil/trace.go:171","msg":"trace[1683558265] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"262.44693ms","start":"2026-04-18T22:17:45.984283Z","end":"2026-04-18T22:17:46.24673Z","steps":["trace[1683558265] 'agreement among raft nodes before linearized reading' (duration: 246.978597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.158548ms","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:17:46.247106Z","caller":"traceutil/trace.go:171","msg":"trace[1682354614] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"167.574106ms","start":"2026-04-18T22:17:46.079522Z","end":"2026-04-18T22:17:46.247096Z","steps":["trace[1682354614] 'agreement among raft nodes before linearized reading' (duration: 151.605762ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:46.246468Z","caller":"traceutil/trace.go:171","msg":"trace[1602442733] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:627; }","duration":"165.965071ms","start":"2026-04-18T22:17:46.080292Z","end":"2026-04-18T22:17:46.246257Z","steps":["trace[1602442733] 'agreement among raft nodes before linearized reading' (duration: 150.828205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.355798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.247276Z","caller":"traceutil/trace.go:171","msg":"trace[968400606] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:627; }","duration":"263.30537ms","start":"2026-04-18T22:17:45.983956Z","end":"2026-04-18T22:17:46.247262Z","steps":["trace[968400606] 'agreement among raft nodes before linearized reading' (duration: 247.318514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.503359ms","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:17:46.247337Z","caller":"traceutil/trace.go:171","msg":"trace[1444616460] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"138.329269ms","start":"2026-04-18T22:17:46.109Z","end":"2026-04-18T22:17:46.247329Z","steps":["trace[1444616460] 'agreement among raft nodes before linearized reading' (duration: 122.113977ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:46.246741Z","caller":"traceutil/trace.go:171","msg":"trace[1249036501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"178.671061ms","start":"2026-04-18T22:17:46.068063Z","end":"2026-04-18T22:17:46.246734Z","steps":["trace[1249036501] 'agreement among raft nodes before linearized reading' (duration: 163.074425ms)","trace[1249036501] 'range keys from in-memory index tree' (duration: 15.397852ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:17:46.246704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.397516ms","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:17:46.247475Z","caller":"traceutil/trace.go:171","msg":"trace[1897566057] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"138.310618ms","start":"2026-04-18T22:17:46.109154Z","end":"2026-04-18T22:17:46.247464Z","steps":["trace[1897566057] 'agreement among raft nodes before linearized reading' (duration: 121.920063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.927944Z","time spent":"318.80145ms","remote":"127.0.0.1:56066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-18T22:17:46.246807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.579016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.247611Z","caller":"traceutil/trace.go:171","msg":"trace[1795066424] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:627; }","duration":"526.401155ms","start":"2026-04-18T22:17:45.7212Z","end":"2026-04-18T22:17:46.247602Z","steps":["trace[1795066424] 'agreement among raft nodes before linearized reading' (duration: 509.561169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.247643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.721189Z","time spent":"526.443666ms","remote":"127.0.0.1:56044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-18T22:17:46.246141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.703133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.247748Z","caller":"traceutil/trace.go:171","msg":"trace[2071288486] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:627; }","duration":"332.318861ms","start":"2026-04-18T22:17:45.9154Z","end":"2026-04-18T22:17:46.247719Z","steps":["trace[2071288486] 'agreement among raft nodes before linearized reading' (duration: 315.747931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.247787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:17:45.91538Z","time spent":"332.394573ms","remote":"127.0.0.1:56060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-18T22:17:46.24691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.777662ms","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:17:46.247864Z","caller":"traceutil/trace.go:171","msg":"trace[1609213382] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:627; }","duration":"137.743434ms","start":"2026-04-18T22:17:46.110107Z","end":"2026-04-18T22:17:46.24785Z","steps":["trace[1609213382] 'agreement among raft nodes before linearized reading' (duration: 120.96006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.335343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.247996Z","caller":"traceutil/trace.go:171","msg":"trace[1262882496] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:627; }","duration":"113.385997ms","start":"2026-04-18T22:17:46.134572Z","end":"2026-04-18T22:17:46.247958Z","steps":["trace[1262882496] 'agreement among raft nodes before linearized reading' (duration: 96.47473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.104489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.248084Z","caller":"traceutil/trace.go:171","msg":"trace[835453522] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:627; }","duration":"114.250087ms","start":"2026-04-18T22:17:46.133824Z","end":"2026-04-18T22:17:46.248074Z","steps":["trace[835453522] 'agreement among raft nodes before linearized reading' (duration: 97.237317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:17:46.246963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.098259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:17:46.248182Z","caller":"traceutil/trace.go:171","msg":"trace[1446840445] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:627; }","duration":"114.344649ms","start":"2026-04-18T22:17:46.13383Z","end":"2026-04-18T22:17:46.248175Z","steps":["trace[1446840445] 'agreement among raft nodes before linearized reading' (duration: 97.224497ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:47.253351Z","caller":"traceutil/trace.go:171","msg":"trace[1452141928] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"150.894076ms","start":"2026-04-18T22:17:47.10243Z","end":"2026-04-18T22:17:47.253324Z","steps":["trace[1452141928] 'process raft request' (duration: 136.146837ms)","trace[1452141928] 'compare' (duration: 14.649586ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:17:48.227354Z","caller":"traceutil/trace.go:171","msg":"trace[2075562509] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"110.172012ms","start":"2026-04-18T22:17:48.117153Z","end":"2026-04-18T22:17:48.227325Z","steps":["trace[2075562509] 'process raft request' (duration: 109.944967ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:17:59.500122Z","caller":"traceutil/trace.go:171","msg":"trace[1260223798] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"185.326864ms","start":"2026-04-18T22:17:59.314765Z","end":"2026-04-18T22:17:59.500091Z","steps":["trace[1260223798] 'process raft request' (duration: 185.072408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:02.41414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.648719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T22:18:02.414218Z","caller":"traceutil/trace.go:171","msg":"trace[1525662091] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:783; }","duration":"625.793562ms","start":"2026-04-18T22:18:01.788408Z","end":"2026-04-18T22:18:02.414202Z","steps":["trace[1525662091] 'range keys from in-memory index tree' (duration: 625.480735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:02.414254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:01.788377Z","time spent":"625.868764ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-18T22:18:02.517298Z","caller":"traceutil/trace.go:171","msg":"trace[525802965] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"431.712596ms","start":"2026-04-18T22:18:02.085568Z","end":"2026-04-18T22:18:02.51728Z","steps":["trace[525802965] 'process raft request' (duration: 431.489491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:02.517438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:02.085535Z","time spent":"431.828398ms","remote":"127.0.0.1:45016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:02.517711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.289829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T22:18:02.517802Z","caller":"traceutil/trace.go:171","msg":"trace[829029567] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:784; }","duration":"173.464643ms","start":"2026-04-18T22:18:02.344316Z","end":"2026-04-18T22:18:02.517781Z","steps":["trace[829029567] 'agreement among raft nodes before linearized reading' (duration: 173.113944ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:02.517819Z","caller":"traceutil/trace.go:171","msg":"trace[1128965054] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"172.845537ms","start":"2026-04-18T22:18:02.344397Z","end":"2026-04-18T22:18:02.517242Z","steps":["trace[1128965054] 'read index received' (duration: 172.734445ms)","trace[1128965054] 'applied index is now lower than readState.Index' (duration: 110.152µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:02.547421Z","caller":"traceutil/trace.go:171","msg":"trace[132771506] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"128.747359ms","start":"2026-04-18T22:18:02.418658Z","end":"2026-04-18T22:18:02.547406Z","steps":["trace[132771506] 'process raft request' (duration: 128.566174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:02.547537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.860845ms","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:18:02.547616Z","caller":"traceutil/trace.go:171","msg":"trace[26878522] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:785; }","duration":"126.965937ms","start":"2026-04-18T22:18:02.420632Z","end":"2026-04-18T22:18:02.547598Z","steps":["trace[26878522] 'agreement among raft nodes before linearized reading' (duration: 126.747092ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:31.899004Z","caller":"traceutil/trace.go:171","msg":"trace[828713018] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"109.134354ms","start":"2026-04-18T22:18:31.789852Z","end":"2026-04-18T22:18:31.898986Z","steps":["trace[828713018] 'process raft request' (duration: 109.014162ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:37.436102Z","caller":"traceutil/trace.go:171","msg":"trace[1639317084] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"164.624087ms","start":"2026-04-18T22:18:37.271448Z","end":"2026-04-18T22:18:37.436072Z","steps":["trace[1639317084] 'process raft request' (duration: 164.433793ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:37.992439Z","caller":"traceutil/trace.go:171","msg":"trace[1201804830] linearizableReadLoop","detail":"{readStateIndex:1039; appliedIndex:1038; }","duration":"194.386993ms","start":"2026-04-18T22:18:37.798033Z","end":"2026-04-18T22:18:37.99242Z","steps":["trace[1201804830] 'read index received' (duration: 194.350022ms)","trace[1201804830] 'applied index is now lower than readState.Index' (duration: 36.371µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:37.992686Z","caller":"traceutil/trace.go:171","msg":"trace[2097519107] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"421.232097ms","start":"2026-04-18T22:18:37.571445Z","end":"2026-04-18T22:18:37.992677Z","steps":["trace[2097519107] 'process raft request' (duration: 420.806428ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:37.992782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:37.57141Z","time spent":"421.306039ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:37.992905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.851743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:18:37.992992Z","caller":"traceutil/trace.go:171","msg":"trace[276943984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1000; }","duration":"194.996966ms","start":"2026-04-18T22:18:37.797977Z","end":"2026-04-18T22:18:37.992974Z","steps":["trace[276943984] 'agreement among raft nodes before linearized reading' (duration: 194.821412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:39.647045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.405806654s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:18:39.647145Z","caller":"traceutil/trace.go:171","msg":"trace[662114013] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"907.99571ms","start":"2026-04-18T22:18:38.739132Z","end":"2026-04-18T22:18:39.647128Z","steps":["trace[662114013] 'read index received' (duration: 41.301µs)","trace[662114013] 'applied index is now lower than readState.Index' (duration: 907.953009ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:18:39.647359Z","caller":"traceutil/trace.go:171","msg":"trace[704265353] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"1.649659342s","start":"2026-04-18T22:18:37.997687Z","end":"2026-04-18T22:18:39.647346Z","steps":["trace[704265353] 'process raft request' (duration: 243.444278ms)","trace[704265353] 'compare' (duration: 1.405341514s)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:18:39.64742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:37.997669Z","time spent":"1.649720393s","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:18:39.647692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"908.556313ms","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:18:39.647723Z","caller":"traceutil/trace.go:171","msg":"trace[156554008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1001; }","duration":"908.628505ms","start":"2026-04-18T22:18:38.739085Z","end":"2026-04-18T22:18:39.647713Z","steps":["trace[156554008] 'agreement among raft nodes before linearized reading' (duration: 908.493301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:39.647749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:38.739063Z","time spent":"908.680096ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-18T22:18:39.647941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.661586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-18T22:18:39.64803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.415388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:18:39.648109Z","caller":"traceutil/trace.go:171","msg":"trace[1557936687] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1001; }","duration":"484.540171ms","start":"2026-04-18T22:18:39.16355Z","end":"2026-04-18T22:18:39.64809Z","steps":["trace[1557936687] 'agreement among raft nodes before linearized reading' (duration: 484.396568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:39.648155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.163533Z","time spent":"484.614682ms","remote":"127.0.0.1:44770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:18:39.648264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.478354ms","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:18:39.648341Z","caller":"traceutil/trace.go:171","msg":"trace[1747326306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1001; }","duration":"208.594637ms","start":"2026-04-18T22:18:39.439727Z","end":"2026-04-18T22:18:39.648322Z","steps":["trace[1747326306] 'agreement among raft nodes before linearized reading' (duration: 208.388133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:39.648623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.358479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T22:18:39.648663Z","caller":"traceutil/trace.go:171","msg":"trace[2038898650] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1001; }","duration":"881.443761ms","start":"2026-04-18T22:18:38.767209Z","end":"2026-04-18T22:18:39.648653Z","steps":["trace[2038898650] 'agreement among raft nodes before linearized reading' (duration: 881.311728ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:39.648663Z","caller":"traceutil/trace.go:171","msg":"trace[807831535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1001; }","duration":"898.707447ms","start":"2026-04-18T22:18:38.749252Z","end":"2026-04-18T22:18:39.647959Z","steps":["trace[807831535] 'agreement among raft nodes before linearized reading' (duration: 898.634415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:39.648693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:38.767185Z","time spent":"881.503491ms","remote":"127.0.0.1:45036","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:18:39.648715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:38.749242Z","time spent":"899.459364ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-18T22:18:40.182673Z","caller":"traceutil/trace.go:171","msg":"trace[792212456] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"529.584815ms","start":"2026-04-18T22:18:39.65306Z","end":"2026-04-18T22:18:40.182645Z","steps":["trace[792212456] 'process raft request' (duration: 529.325199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:40.182901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.653041Z","time spent":"529.700847ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:40.183221Z","caller":"traceutil/trace.go:171","msg":"trace[1709866164] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"530.099876ms","start":"2026-04-18T22:18:39.653074Z","end":"2026-04-18T22:18:40.183173Z","steps":["trace[1709866164] 'process raft request' (duration: 529.526563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:40.183522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.653058Z","time spent":"530.23879ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:40.208707Z","caller":"traceutil/trace.go:171","msg":"trace[1817400569] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"555.557741ms","start":"2026-04-18T22:18:39.653128Z","end":"2026-04-18T22:18:40.208686Z","steps":["trace[1817400569] 'process raft request' (duration: 555.395117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:40.208944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.653106Z","time spent":"555.650313ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:18:40.209007Z","caller":"traceutil/trace.go:171","msg":"trace[1279908809] transaction","detail":"{read_only:false; response_revision:1005; number_of_response:1; }","duration":"555.266614ms","start":"2026-04-18T22:18:39.653716Z","end":"2026-04-18T22:18:40.208983Z","steps":["trace[1279908809] 'process raft request' (duration: 554.912766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:40.209163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.050658ms","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:18:40.209221Z","caller":"traceutil/trace.go:171","msg":"trace[226846328] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1006; }","duration":"446.16709ms","start":"2026-04-18T22:18:39.763039Z","end":"2026-04-18T22:18:40.209206Z","steps":["trace[226846328] 'agreement among raft nodes before linearized reading' (duration: 446.021187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:40.209266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.763022Z","time spent":"446.233772ms","remote":"127.0.0.1:45206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:18:40.209245Z","caller":"traceutil/trace.go:171","msg":"trace[767706265] transaction","detail":"{read_only:false; response_revision:1006; number_of_response:1; }","duration":"210.348388ms","start":"2026-04-18T22:18:39.99888Z","end":"2026-04-18T22:18:40.209228Z","steps":["trace[767706265] 'process raft request' (duration: 209.98646ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:18:40.20901Z","caller":"traceutil/trace.go:171","msg":"trace[1744431537] linearizableReadLoop","detail":"{readStateIndex:1044; appliedIndex:1040; }","duration":"445.890954ms","start":"2026-04-18T22:18:39.763094Z","end":"2026-04-18T22:18:40.208985Z","steps":["trace[1744431537] 'read index received' (duration: 419.444768ms)","trace[1744431537] 'applied index is now lower than readState.Index' (duration: 26.445116ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:18:40.209712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.32394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:18:40.209748Z","caller":"traceutil/trace.go:171","msg":"trace[166713715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1006; }","duration":"414.395441ms","start":"2026-04-18T22:18:39.795344Z","end":"2026-04-18T22:18:40.209739Z","steps":["trace[166713715] 'agreement among raft nodes before linearized reading' (duration: 414.33392ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:18:40.209775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.795334Z","time spent":"414.436722ms","remote":"127.0.0.1:44780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:18:40.209745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:18:39.65368Z","time spent":"555.993631ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:19:02.671416Z","caller":"traceutil/trace.go:171","msg":"trace[909745485] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"341.847394ms","start":"2026-04-18T22:19:02.329524Z","end":"2026-04-18T22:19:02.671372Z","steps":["trace[909745485] 'read index received' (duration: 341.708601ms)","trace[909745485] 'applied index is now lower than readState.Index' (duration: 136.913µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:02.671451Z","caller":"traceutil/trace.go:171","msg":"trace[1069094478] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"343.503002ms","start":"2026-04-18T22:19:02.327905Z","end":"2026-04-18T22:19:02.671408Z","steps":["trace[1069094478] 'process raft request' (duration: 343.223076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.671686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.131342ms","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:19:02.6718Z","caller":"traceutil/trace.go:171","msg":"trace[451135147] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1075; }","duration":"342.294196ms","start":"2026-04-18T22:19:02.329484Z","end":"2026-04-18T22:19:02.671778Z","steps":["trace[451135147] 'agreement among raft nodes before linearized reading' (duration: 342.021879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:02.671853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.329472Z","time spent":"342.368077ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-18T22:19:02.672098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.327873Z","time spent":"343.733539ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:19:03.179343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.20928ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:19:03.179518Z","caller":"traceutil/trace.go:171","msg":"trace[372697497] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"572.477629ms","start":"2026-04-18T22:19:02.607009Z","end":"2026-04-18T22:19:03.179487Z","steps":["trace[372697497] 'process raft request' (duration: 208.023943ms)","trace[372697497] 'compare' (duration: 364.063477ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:03.179571Z","caller":"traceutil/trace.go:171","msg":"trace[808113558] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"502.211727ms","start":"2026-04-18T22:19:02.677341Z","end":"2026-04-18T22:19:03.179552Z","steps":["trace[808113558] 'process raft request' (duration: 502.141816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.179654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.677315Z","time spent":"502.2974ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:19:03.179654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.606982Z","time spent":"572.593422ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:19:03.179856Z","caller":"traceutil/trace.go:171","msg":"trace[2110375005] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1119; }","duration":"508.255066ms","start":"2026-04-18T22:19:02.671537Z","end":"2026-04-18T22:19:03.179792Z","steps":["trace[2110375005] 'read index received' (duration: 143.585635ms)","trace[2110375005] 'applied index is now lower than readState.Index' (duration: 364.66316ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:03.180202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.405686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-18T22:19:03.180211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.388804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:19:03.180251Z","caller":"traceutil/trace.go:171","msg":"trace[1845542457] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1077; }","duration":"839.476547ms","start":"2026-04-18T22:19:02.340762Z","end":"2026-04-18T22:19:03.180239Z","steps":["trace[1845542457] 'agreement among raft nodes before linearized reading' (duration: 839.333433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.180289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.340752Z","time spent":"839.529799ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-18T22:19:03.180281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.106952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-18T22:19:03.1803Z","caller":"traceutil/trace.go:171","msg":"trace[270364020] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1077; }","duration":"503.505967ms","start":"2026-04-18T22:19:02.676768Z","end":"2026-04-18T22:19:03.180274Z","steps":["trace[270364020] 'agreement among raft nodes before linearized reading' (duration: 503.359924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.180314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.204374ms","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:19:03.180337Z","caller":"traceutil/trace.go:171","msg":"trace[847596946] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1077; }","duration":"837.178435ms","start":"2026-04-18T22:19:02.343144Z","end":"2026-04-18T22:19:03.180323Z","steps":["trace[847596946] 'agreement among raft nodes before linearized reading' (duration: 837.006361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.180527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.676754Z","time spent":"503.583189ms","remote":"127.0.0.1:45246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":2,"response size":30,"request content":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:19:03.180544Z","caller":"traceutil/trace.go:171","msg":"trace[39488994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1077; }","duration":"786.519631ms","start":"2026-04-18T22:19:02.39401Z","end":"2026-04-18T22:19:03.18053Z","steps":["trace[39488994] 'agreement among raft nodes before linearized reading' (duration: 786.04032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.180553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.343088Z","time spent":"837.457831ms","remote":"127.0.0.1:45036","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:19:03.180568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.748365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-18T22:19:03.180594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.393984Z","time spent":"786.601353ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-18T22:19:03.180612Z","caller":"traceutil/trace.go:171","msg":"trace[1890979494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1077; }","duration":"382.812197ms","start":"2026-04-18T22:19:02.797786Z","end":"2026-04-18T22:19:03.180598Z","steps":["trace[1890979494] 'agreement among raft nodes before linearized reading' (duration: 382.742215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.180677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:02.797775Z","time spent":"382.894968ms","remote":"127.0.0.1:44770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T22:19:03.411472Z","caller":"traceutil/trace.go:171","msg":"trace[2013866363] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"227.040111ms","start":"2026-04-18T22:19:03.184392Z","end":"2026-04-18T22:19:03.411432Z","steps":["trace[2013866363] 'process raft request' (duration: 131.130309ms)","trace[2013866363] 'compare' (duration: 95.729438ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:03.572336Z","caller":"traceutil/trace.go:171","msg":"trace[1527400413] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"386.252946ms","start":"2026-04-18T22:19:03.186027Z","end":"2026-04-18T22:19:03.57228Z","steps":["trace[1527400413] 'process raft request' (duration: 385.881788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.572628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:03.186009Z","time spent":"386.456811ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:19:03.571975Z","caller":"traceutil/trace.go:171","msg":"trace[1123097123] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"386.195616ms","start":"2026-04-18T22:19:03.185757Z","end":"2026-04-18T22:19:03.571952Z","steps":["trace[1123097123] 'process raft request' (duration: 385.967381ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:03.590353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:03.185738Z","time spent":"404.535216ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:19:04.861453Z","caller":"traceutil/trace.go:171","msg":"trace[546229803] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"177.020013ms","start":"2026-04-18T22:19:04.684413Z","end":"2026-04-18T22:19:04.861433Z","steps":["trace[546229803] 'process raft request' (duration: 176.621424ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:07.328473Z","caller":"traceutil/trace.go:171","msg":"trace[1019534977] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"461.886892ms","start":"2026-04-18T22:19:06.866542Z","end":"2026-04-18T22:19:07.328429Z","steps":["trace[1019534977] 'process raft request' (duration: 461.510463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:07.328944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:06.866508Z","time spent":"462.174418ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:19:07.583826Z","caller":"traceutil/trace.go:171","msg":"trace[662166787] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"249.057956ms","start":"2026-04-18T22:19:07.334742Z","end":"2026-04-18T22:19:07.5838Z","steps":["trace[662166787] 'process raft request' (duration: 248.706568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:20.294286Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219121155646778893,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T22:19:20.953139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.37122ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:19:20.95321Z","caller":"traceutil/trace.go:171","msg":"trace[1086290154] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1231; }","duration":"1.159303057s","start":"2026-04-18T22:19:19.793895Z","end":"2026-04-18T22:19:20.953198Z","steps":["trace[1086290154] 'read index received' (duration: 622.732883ms)","trace[1086290154] 'applied index is now lower than readState.Index' (duration: 536.569564ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:20.953282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.15938769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:19:20.953296Z","caller":"traceutil/trace.go:171","msg":"trace[1680784136] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1183; }","duration":"1.15940078s","start":"2026-04-18T22:19:19.79389Z","end":"2026-04-18T22:19:20.953291Z","steps":["trace[1680784136] 'agreement among raft nodes before linearized reading' (duration: 1.159373389s)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:20.953286Z","caller":"traceutil/trace.go:171","msg":"trace[169797647] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"1.175509859s","start":"2026-04-18T22:19:19.777751Z","end":"2026-04-18T22:19:20.953261Z","steps":["trace[169797647] 'process raft request' (duration: 638.955735ms)","trace[169797647] 'compare' (duration: 536.286917ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:20.953316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:19.793854Z","time spent":"1.159458701s","remote":"127.0.0.1:44780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-18T22:19:20.953386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:19.777736Z","time spent":"1.175594432s","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:19:20.953486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.075086464s","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:19:20.953502Z","caller":"traceutil/trace.go:171","msg":"trace[796070997] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1183; }","duration":"1.075123105s","start":"2026-04-18T22:19:19.878374Z","end":"2026-04-18T22:19:20.953497Z","steps":["trace[796070997] 'agreement among raft nodes before linearized reading' (duration: 1.075057153s)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:20.953518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:19.878359Z","time spent":"1.075153136s","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-18T22:19:20.953642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.858846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-18T22:19:20.953644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.365474ms","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:19:20.953657Z","caller":"traceutil/trace.go:171","msg":"trace[490557106] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:1183; }","duration":"588.922057ms","start":"2026-04-18T22:19:20.36473Z","end":"2026-04-18T22:19:20.953652Z","steps":["trace[490557106] 'agreement among raft nodes before linearized reading' (duration: 588.861026ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:20.953667Z","caller":"traceutil/trace.go:171","msg":"trace[87257519] 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:1183; }","duration":"937.420255ms","start":"2026-04-18T22:19:20.016239Z","end":"2026-04-18T22:19:20.953659Z","steps":["trace[87257519] 'agreement among raft nodes before linearized reading' (duration: 937.362394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:20.953674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:20.36471Z","time spent":"588.960178ms","remote":"127.0.0.1:44818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.35\" "} {"level":"warn","ts":"2026-04-18T22:19:20.953685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:20.016216Z","time spent":"937.464356ms","remote":"127.0.0.1:56138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:19:33.12189Z","caller":"traceutil/trace.go:171","msg":"trace[420608159] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"111.757935ms","start":"2026-04-18T22:19:33.010106Z","end":"2026-04-18T22:19:33.121864Z","steps":["trace[420608159] 'process raft request' (duration: 105.689596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:36.009654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.986738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-18T22:19:36.009734Z","caller":"traceutil/trace.go:171","msg":"trace[606133059] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1249; }","duration":"179.152321ms","start":"2026-04-18T22:19:35.830564Z","end":"2026-04-18T22:19:36.009716Z","steps":["trace[606133059] 'range keys from in-memory index tree' (duration: 178.746252ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:36.176761Z","caller":"traceutil/trace.go:171","msg":"trace[991699173] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"110.428794ms","start":"2026-04-18T22:19:36.066311Z","end":"2026-04-18T22:19:36.17673Z","steps":["trace[991699173] 'process raft request' (duration: 72.142805ms)","trace[991699173] 'compare' (duration: 38.203367ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:36.930759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.520429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:19:36.931372Z","caller":"traceutil/trace.go:171","msg":"trace[185221564] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"732.050039ms","start":"2026-04-18T22:19:36.199273Z","end":"2026-04-18T22:19:36.931324Z","steps":["trace[185221564] 'process raft request' (duration: 219.879975ms)","trace[185221564] 'compare' (duration: 511.388456ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:36.931563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:36.199259Z","time spent":"732.201112ms","remote":"127.0.0.1:45152","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-18T22:19:37.239754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.873337ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-18T22:19:37.23992Z","caller":"traceutil/trace.go:171","msg":"trace[1411694378] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1303; }","duration":"783.170351ms","start":"2026-04-18T22:19:36.456722Z","end":"2026-04-18T22:19:37.239893Z","steps":["trace[1411694378] 'read index received' (duration: 126.967624ms)","trace[1411694378] 'applied index is now lower than readState.Index' (duration: 656.199977ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:37.24007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.332235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-4wpz5\" ","response":"range_response_count:1 size:11057"} {"level":"info","ts":"2026-04-18T22:19:37.240145Z","caller":"traceutil/trace.go:171","msg":"trace[1030824100] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-4wpz5; range_end:; response_count:1; response_revision:1252; }","duration":"783.435027ms","start":"2026-04-18T22:19:36.456694Z","end":"2026-04-18T22:19:37.240129Z","steps":["trace[1030824100] 'agreement among raft nodes before linearized reading' (duration: 783.277273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:37.240171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:36.456682Z","time spent":"783.483819ms","remote":"127.0.0.1:44976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11080,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-4wpz5\" "} {"level":"warn","ts":"2026-04-18T22:19:37.240217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.488338ms","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:19:37.240254Z","caller":"traceutil/trace.go:171","msg":"trace[1977220092] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1252; }","duration":"169.57291ms","start":"2026-04-18T22:19:37.070668Z","end":"2026-04-18T22:19:37.24024Z","steps":["trace[1977220092] 'agreement among raft nodes before linearized reading' (duration: 169.373986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:37.240425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.540608ms","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:19:37.240445Z","caller":"traceutil/trace.go:171","msg":"trace[848437389] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1252; }","duration":"107.581469ms","start":"2026-04-18T22:19:37.132858Z","end":"2026-04-18T22:19:37.240439Z","steps":["trace[848437389] 'agreement among raft nodes before linearized reading' (duration: 107.525026ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:37.436998Z","caller":"traceutil/trace.go:171","msg":"trace[1206706144] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"104.141421ms","start":"2026-04-18T22:19:37.332833Z","end":"2026-04-18T22:19:37.436974Z","steps":["trace[1206706144] 'process raft request' (duration: 103.946586ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:37.919516Z","caller":"traceutil/trace.go:171","msg":"trace[406888002] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"134.833464ms","start":"2026-04-18T22:19:37.78465Z","end":"2026-04-18T22:19:37.919484Z","steps":["trace[406888002] 'process raft request' (duration: 134.634909ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:37.94849Z","caller":"traceutil/trace.go:171","msg":"trace[1763035079] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1313; }","duration":"153.647896ms","start":"2026-04-18T22:19:37.794813Z","end":"2026-04-18T22:19:37.94846Z","steps":["trace[1763035079] 'read index received' (duration: 124.427826ms)","trace[1763035079] 'applied index is now lower than readState.Index' (duration: 29.21842ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:37.948633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.80675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:19:37.94867Z","caller":"traceutil/trace.go:171","msg":"trace[1178154529] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1262; }","duration":"153.888222ms","start":"2026-04-18T22:19:37.794767Z","end":"2026-04-18T22:19:37.948656Z","steps":["trace[1178154529] 'agreement among raft nodes before linearized reading' (duration: 153.80671ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:37.948668Z","caller":"traceutil/trace.go:171","msg":"trace[1504809108] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"162.411827ms","start":"2026-04-18T22:19:37.786202Z","end":"2026-04-18T22:19:37.948614Z","steps":["trace[1504809108] 'process raft request' (duration: 162.072299ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:38.34605Z","caller":"traceutil/trace.go:171","msg":"trace[1165467914] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"279.35671ms","start":"2026-04-18T22:19:38.066661Z","end":"2026-04-18T22:19:38.346018Z","steps":["trace[1165467914] 'process raft request' (duration: 271.483599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:38.346187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.254745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:19:38.346257Z","caller":"traceutil/trace.go:171","msg":"trace[165373315] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1264; }","duration":"227.386797ms","start":"2026-04-18T22:19:38.118857Z","end":"2026-04-18T22:19:38.346244Z","steps":["trace[165373315] 'agreement among raft nodes before linearized reading' (duration: 227.244324ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:38.346029Z","caller":"traceutil/trace.go:171","msg":"trace[581140529] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1316; }","duration":"227.06385ms","start":"2026-04-18T22:19:38.1189Z","end":"2026-04-18T22:19:38.345964Z","steps":["trace[581140529] 'read index received' (duration: 219.273681ms)","trace[581140529] 'applied index is now lower than readState.Index' (duration: 7.788599ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:38.934069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3219121155646779071,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-18T22:19:39.300454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.447141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-18T22:19:39.300655Z","caller":"traceutil/trace.go:171","msg":"trace[1716235957] linearizableReadLoop","detail":"{readStateIndex:1320; appliedIndex:1318; }","duration":"867.252752ms","start":"2026-04-18T22:19:38.433385Z","end":"2026-04-18T22:19:39.300638Z","steps":["trace[1716235957] 'read index received' (duration: 689.80419ms)","trace[1716235957] 'applied index is now lower than readState.Index' (duration: 177.447642ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:39.300738Z","caller":"traceutil/trace.go:171","msg":"trace[793571222] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"947.052013ms","start":"2026-04-18T22:19:38.353674Z","end":"2026-04-18T22:19:39.300726Z","steps":["trace[793571222] 'process raft request' (duration: 946.878349ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:39.300726Z","caller":"traceutil/trace.go:171","msg":"trace[195895859] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"949.189622ms","start":"2026-04-18T22:19:38.351491Z","end":"2026-04-18T22:19:39.30068Z","steps":["trace[195895859] 'process raft request' (duration: 771.474134ms)","trace[195895859] 'compare' (duration: 177.255507ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:39.300793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:38.353665Z","time spent":"947.095893ms","remote":"127.0.0.1:44850","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:19:39.300898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:38.35147Z","time spent":"949.343805ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":456,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-18T22:19:39.301048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.532136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-18T22:19:39.301133Z","caller":"traceutil/trace.go:171","msg":"trace[1123207984] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"500.657599ms","start":"2026-04-18T22:19:38.800454Z","end":"2026-04-18T22:19:39.301112Z","steps":["trace[1123207984] 'agreement among raft nodes before linearized reading' (duration: 500.472165ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:39.301167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.727285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-18T22:19:39.301182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:38.800434Z","time spent":"500.739911ms","remote":"127.0.0.1:44770","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-18T22:19:39.301204Z","caller":"traceutil/trace.go:171","msg":"trace[504982281] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1267; }","duration":"115.770726ms","start":"2026-04-18T22:19:39.185423Z","end":"2026-04-18T22:19:39.301194Z","steps":["trace[504982281] 'agreement among raft nodes before linearized reading' (duration: 115.698875ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:39.301299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"867.898196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:19:39.301367Z","caller":"traceutil/trace.go:171","msg":"trace[1178742595] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1267; }","duration":"868.008709ms","start":"2026-04-18T22:19:38.433341Z","end":"2026-04-18T22:19:39.301349Z","steps":["trace[1178742595] 'agreement among raft nodes before linearized reading' (duration: 867.907876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:39.301401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:38.433326Z","time spent":"868.06614ms","remote":"127.0.0.1:45152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-04-18T22:19:40.231503Z","caller":"traceutil/trace.go:171","msg":"trace[202632514] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1325; }","duration":"278.304556ms","start":"2026-04-18T22:19:39.95317Z","end":"2026-04-18T22:19:40.231474Z","steps":["trace[202632514] 'read index received' (duration: 278.06701ms)","trace[202632514] 'applied index is now lower than readState.Index' (duration: 236.756µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:40.23173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.528541ms","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:19:40.231719Z","caller":"traceutil/trace.go:171","msg":"trace[1123749360] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"299.840811ms","start":"2026-04-18T22:19:39.931851Z","end":"2026-04-18T22:19:40.231692Z","steps":["trace[1123749360] 'process raft request' (duration: 299.448562ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:40.231768Z","caller":"traceutil/trace.go:171","msg":"trace[672226413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1273; }","duration":"278.613613ms","start":"2026-04-18T22:19:39.953144Z","end":"2026-04-18T22:19:40.231758Z","steps":["trace[672226413] 'agreement among raft nodes before linearized reading' (duration: 278.435459ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:40.466225Z","caller":"traceutil/trace.go:171","msg":"trace[984090003] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"114.729822ms","start":"2026-04-18T22:19:40.351468Z","end":"2026-04-18T22:19:40.466198Z","steps":["trace[984090003] 'read index received' (duration: 90.036236ms)","trace[984090003] 'applied index is now lower than readState.Index' (duration: 24.692296ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:40.466359Z","caller":"traceutil/trace.go:171","msg":"trace[34081213] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"229.276231ms","start":"2026-04-18T22:19:40.237043Z","end":"2026-04-18T22:19:40.466319Z","steps":["trace[34081213] 'process raft request' (duration: 204.487892ms)","trace[34081213] 'compare' (duration: 24.532533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:40.46649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.997419ms","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:19:40.466531Z","caller":"traceutil/trace.go:171","msg":"trace[626924374] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1274; }","duration":"115.106402ms","start":"2026-04-18T22:19:40.351416Z","end":"2026-04-18T22:19:40.466522Z","steps":["trace[626924374] 'agreement among raft nodes before linearized reading' (duration: 114.937788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:40.46656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.490248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.35\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-18T22:19:40.466632Z","caller":"traceutil/trace.go:171","msg":"trace[475901070] range","detail":"{range_begin:/registry/masterleases/199.204.45.35; range_end:; response_count:1; response_revision:1274; }","duration":"101.627442ms","start":"2026-04-18T22:19:40.364985Z","end":"2026-04-18T22:19:40.466612Z","steps":["trace[475901070] 'agreement among raft nodes before linearized reading' (duration: 101.391206ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:40.761253Z","caller":"traceutil/trace.go:171","msg":"trace[985052833] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"285.938181ms","start":"2026-04-18T22:19:40.475271Z","end":"2026-04-18T22:19:40.761209Z","steps":["trace[985052833] 'process raft request' (duration: 240.580291ms)","trace[985052833] 'compare' (duration: 44.940701ms)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:40.761462Z","caller":"traceutil/trace.go:171","msg":"trace[1781939149] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"213.926519ms","start":"2026-04-18T22:19:40.547513Z","end":"2026-04-18T22:19:40.76144Z","steps":["trace[1781939149] 'process raft request' (duration: 213.634432ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:41.650596Z","caller":"traceutil/trace.go:171","msg":"trace[632586347] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"194.260079ms","start":"2026-04-18T22:19:41.456302Z","end":"2026-04-18T22:19:41.650562Z","steps":["trace[632586347] 'read index received' (duration: 194.013493ms)","trace[632586347] 'applied index is now lower than readState.Index' (duration: 244.876µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:41.650732Z","caller":"traceutil/trace.go:171","msg":"trace[784322584] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"268.866429ms","start":"2026-04-18T22:19:41.381819Z","end":"2026-04-18T22:19:41.650685Z","steps":["trace[784322584] 'process raft request' (duration: 268.498111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:41.65103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.689748ms","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:19:41.6511Z","caller":"traceutil/trace.go:171","msg":"trace[587715010] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1277; }","duration":"194.818541ms","start":"2026-04-18T22:19:41.456266Z","end":"2026-04-18T22:19:41.651084Z","steps":["trace[587715010] 'agreement among raft nodes before linearized reading' (duration: 194.532985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:41.670157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.909133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:19:41.670244Z","caller":"traceutil/trace.go:171","msg":"trace[364967014] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:1278; }","duration":"144.061137ms","start":"2026-04-18T22:19:41.526163Z","end":"2026-04-18T22:19:41.670225Z","steps":["trace[364967014] 'agreement among raft nodes before linearized reading' (duration: 143.867262ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:51.125408Z","caller":"traceutil/trace.go:171","msg":"trace[1121856918] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"286.008463ms","start":"2026-04-18T22:19:50.83937Z","end":"2026-04-18T22:19:51.125378Z","steps":["trace[1121856918] 'read index received' (duration: 285.8973ms)","trace[1121856918] 'applied index is now lower than readState.Index' (duration: 110.153µs)"],"step_count":2} {"level":"info","ts":"2026-04-18T22:19:51.125528Z","caller":"traceutil/trace.go:171","msg":"trace[106892349] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"306.692227ms","start":"2026-04-18T22:19:50.818802Z","end":"2026-04-18T22:19:51.125495Z","steps":["trace[106892349] 'process raft request' (duration: 306.38572ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:51.1256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.214358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-18T22:19:51.125657Z","caller":"traceutil/trace.go:171","msg":"trace[645995419] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1312; }","duration":"286.358341ms","start":"2026-04-18T22:19:50.839289Z","end":"2026-04-18T22:19:51.125648Z","steps":["trace[645995419] 'agreement among raft nodes before linearized reading' (duration: 286.242768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-18T22:19:51.125755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-18T22:19:50.818769Z","time spent":"306.836581ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-18T22:19:53.835913Z","caller":"traceutil/trace.go:171","msg":"trace[67249507] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"117.332472ms","start":"2026-04-18T22:19:53.718555Z","end":"2026-04-18T22:19:53.835888Z","steps":["trace[67249507] 'process raft request' (duration: 117.173638ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:53.838827Z","caller":"traceutil/trace.go:171","msg":"trace[1489079844] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"111.852437ms","start":"2026-04-18T22:19:53.726946Z","end":"2026-04-18T22:19:53.838798Z","steps":["trace[1489079844] 'process raft request' (duration: 111.495788ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:55.314541Z","caller":"traceutil/trace.go:171","msg":"trace[397448381] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"172.273603ms","start":"2026-04-18T22:19:55.142242Z","end":"2026-04-18T22:19:55.314516Z","steps":["trace[397448381] 'read index received' (duration: 172.029158ms)","trace[397448381] 'applied index is now lower than readState.Index' (duration: 230.935µs)"],"step_count":2} {"level":"warn","ts":"2026-04-18T22:19:55.31477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.501938ms","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:19:55.314814Z","caller":"traceutil/trace.go:171","msg":"trace[1294799120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1333; }","duration":"172.566009ms","start":"2026-04-18T22:19:55.142234Z","end":"2026-04-18T22:19:55.3148Z","steps":["trace[1294799120] 'agreement among raft nodes before linearized reading' (duration: 172.386255ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:55.314884Z","caller":"traceutil/trace.go:171","msg":"trace[2105505003] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"237.836287ms","start":"2026-04-18T22:19:55.076949Z","end":"2026-04-18T22:19:55.314785Z","steps":["trace[2105505003] 'process raft request' (duration: 237.379037ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:19:57.573401Z","caller":"traceutil/trace.go:171","msg":"trace[1400882142] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"212.733392ms","start":"2026-04-18T22:19:57.360645Z","end":"2026-04-18T22:19:57.573378Z","steps":["trace[1400882142] 'process raft request' (duration: 212.23989ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:23:17.662457Z","caller":"traceutil/trace.go:171","msg":"trace[1423694497] transaction","detail":"{read_only:false; response_revision:2313; number_of_response:1; }","duration":"171.303031ms","start":"2026-04-18T22:23:17.491115Z","end":"2026-04-18T22:23:17.662418Z","steps":["trace[1423694497] 'process raft request' (duration: 170.906782ms)"],"step_count":1} {"level":"info","ts":"2026-04-18T22:23:18.543018Z","caller":"traceutil/trace.go:171","msg":"trace[767253059] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"111.991171ms","start":"2026-04-18T22:23:18.431002Z","end":"2026-04-18T22:23:18.542993Z","steps":["trace[767253059] 'process raft request' (duration: 108.640535ms)"],"step_count":1}