{"level":"warn","ts":"2026-04-29T15:17:02.514346Z","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-29T15:17:02.514525Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242: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-29T15:17:02.514614Z","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-29T15:17:02.514646Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-29T15:17:02.514677Z","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-29T15:17:02.515347Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-04-29T15:17:02.515488Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242: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-29T15:17:02.519385Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.668611ms"} {"level":"info","ts":"2026-04-29T15:17:02.527592Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-04-29T15:17:02.528053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-04-29T15:17:02.528124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-04-29T15:17:02.528155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-29T15:17:02.528183Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-04-29T15:17:02.52824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-04-29T15:17:02.533838Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-29T15:17:02.536314Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-29T15:17:02.537633Z","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-29T15:17:02.540269Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-29T15:17:02.540489Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-29T15:17:02.541955Z","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-29T15:17:02.542096Z","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-29T15:17:02.542123Z","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-29T15:17:02.543864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-04-29T15:17:02.544137Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-04-29T15:17:02.546701Z","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-29T15:17:02.546808Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-29T15:17:02.546858Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-04-29T15:17:02.54721Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-29T15:17:02.547261Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-29T15:17:02.929371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-04-29T15:17:02.929421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-29T15:17:02.929448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-04-29T15:17:02.92968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-04-29T15:17:02.929717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-29T15:17:02.929751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-04-29T15:17:02.92978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-04-29T15:17:02.930841Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T15:17:02.931775Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-04-29T15:17:02.931884Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T15:17:02.931915Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-29T15:17:02.93239Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T15:17:02.932457Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-29T15:17:02.932515Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-29T15:17:02.932564Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T15:17:02.932598Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-29T15:17:02.934998Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-04-29T15:17:02.935512Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-29T15:17:27.719644Z","caller":"traceutil/trace.go:171","msg":"trace[1277864945] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"649.627631ms","start":"2026-04-29T15:17:27.07Z","end":"2026-04-29T15:17:27.719628Z","steps":["trace[1277864945] 'process raft request' (duration: 649.532008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:27.72006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:27.069989Z","time spent":"649.717563ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:17:28.371776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.104142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:28.371917Z","caller":"traceutil/trace.go:171","msg":"trace[1831109973] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:422; }","duration":"475.33388ms","start":"2026-04-29T15:17:27.896563Z","end":"2026-04-29T15:17:28.371897Z","steps":["trace[1831109973] 'range keys from in-memory index tree' (duration: 475.01968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:28.371962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:27.896542Z","time spent":"475.410922ms","remote":"127.0.0.1:50400","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-29T15:17:28.372295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.520627ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:17:28.372419Z","caller":"traceutil/trace.go:171","msg":"trace[641986833] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"346.38818ms","start":"2026-04-29T15:17:28.026009Z","end":"2026-04-29T15:17:28.372398Z","steps":["trace[641986833] 'process raft request' (duration: 137.503431ms)","trace[641986833] 'compare' (duration: 208.123404ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:17:28.372508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:28.025991Z","time spent":"346.489223ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:17:34.371181Z","caller":"traceutil/trace.go:171","msg":"trace[1195933441] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"624.65756ms","start":"2026-04-29T15:17:33.746493Z","end":"2026-04-29T15:17:34.37115Z","steps":["trace[1195933441] 'process raft request' (duration: 624.491454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.371363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.746465Z","time spent":"624.812885ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:17:34.472391Z","caller":"traceutil/trace.go:171","msg":"trace[148594994] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"670.487097ms","start":"2026-04-29T15:17:33.801808Z","end":"2026-04-29T15:17:34.472295Z","steps":["trace[148594994] 'process raft request' (duration: 670.130395ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:34.472409Z","caller":"traceutil/trace.go:171","msg":"trace[1559423317] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"665.696709ms","start":"2026-04-29T15:17:33.806661Z","end":"2026-04-29T15:17:34.472358Z","steps":["trace[1559423317] 'process raft request' (duration: 665.489002ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:34.472492Z","caller":"traceutil/trace.go:171","msg":"trace[771814704] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"665.743491ms","start":"2026-04-29T15:17:33.806703Z","end":"2026-04-29T15:17:34.472447Z","steps":["trace[771814704] 'process raft request' (duration: 665.501393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.472591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.806652Z","time spent":"665.867045ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-29T15:17:34.472671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.806699Z","time spent":"665.883325ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-29T15:17:34.472578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.801783Z","time spent":"670.717114ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T15:17:34.47363Z","caller":"traceutil/trace.go:171","msg":"trace[1520931461] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"654.105578ms","start":"2026-04-29T15:17:33.819263Z","end":"2026-04-29T15:17:34.473369Z","steps":["trace[1520931461] 'process raft request' (duration: 653.26223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.473752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.819257Z","time spent":"654.450859ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T15:17:34.473795Z","caller":"traceutil/trace.go:171","msg":"trace[422691853] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"654.353987ms","start":"2026-04-29T15:17:33.819218Z","end":"2026-04-29T15:17:34.473572Z","steps":["trace[422691853] 'process raft request' (duration: 653.254461ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:34.473731Z","caller":"traceutil/trace.go:171","msg":"trace[1796644463] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"638.909338ms","start":"2026-04-29T15:17:33.834483Z","end":"2026-04-29T15:17:34.473392Z","steps":["trace[1796644463] 'process raft request' (duration: 638.140362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.473903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.819188Z","time spent":"654.667987ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-29T15:17:34.473982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.834468Z","time spent":"639.415255ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T15:17:34.474201Z","caller":"traceutil/trace.go:171","msg":"trace[2135685857] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"653.608592ms","start":"2026-04-29T15:17:33.819139Z","end":"2026-04-29T15:17:34.472747Z","steps":["trace[2135685857] 'process raft request' (duration: 653.115435ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:34.47431Z","caller":"traceutil/trace.go:171","msg":"trace[925966799] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"639.323442ms","start":"2026-04-29T15:17:33.834792Z","end":"2026-04-29T15:17:34.474115Z","steps":["trace[925966799] 'process raft request' (duration: 637.923616ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:34.474338Z","caller":"traceutil/trace.go:171","msg":"trace[1477485896] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"653.55612ms","start":"2026-04-29T15:17:33.819204Z","end":"2026-04-29T15:17:34.47276Z","steps":["trace[1477485896] 'process raft request' (duration: 653.114555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.474384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.819127Z","time spent":"655.209075ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-29T15:17:34.47445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.819193Z","time spent":"655.218944ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-29T15:17:34.474537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.834782Z","time spent":"639.629132ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T15:17:34.475872Z","caller":"traceutil/trace.go:171","msg":"trace[2134898626] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"629.061255ms","start":"2026-04-29T15:17:33.846791Z","end":"2026-04-29T15:17:34.475853Z","steps":["trace[2134898626] 'process raft request' (duration: 627.803413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.475964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.846775Z","time spent":"629.154637ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T15:17:34.476636Z","caller":"traceutil/trace.go:171","msg":"trace[1751359710] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"588.225902ms","start":"2026-04-29T15:17:33.888343Z","end":"2026-04-29T15:17:34.476569Z","steps":["trace[1751359710] 'process raft request' (duration: 587.23042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.476715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.888283Z","time spent":"588.403388ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T15:17:34.485651Z","caller":"traceutil/trace.go:171","msg":"trace[731669661] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"488.188713ms","start":"2026-04-29T15:17:33.989008Z","end":"2026-04-29T15:17:34.477196Z","steps":["trace[731669661] 'process raft request' (duration: 487.17594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:34.485763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:33.988962Z","time spent":"496.749994ms","remote":"127.0.0.1:50414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-29T15:17:37.112106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.725829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-29T15:17:37.112156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.793688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-29T15:17:37.112225Z","caller":"traceutil/trace.go:171","msg":"trace[1549576483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:550; }","duration":"300.889603ms","start":"2026-04-29T15:17:36.811313Z","end":"2026-04-29T15:17:37.112202Z","steps":["trace[1549576483] 'range keys from in-memory index tree' (duration: 300.542563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:37.112284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:36.811302Z","time spent":"300.970777ms","remote":"127.0.0.1:50624","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":"info","ts":"2026-04-29T15:17:37.112279Z","caller":"traceutil/trace.go:171","msg":"trace[1734530777] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:550; }","duration":"307.022835ms","start":"2026-04-29T15:17:36.80523Z","end":"2026-04-29T15:17:37.112252Z","steps":["trace[1734530777] 'range keys from in-memory index tree' (duration: 306.534709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:37.112145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.710453ms","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-29T15:17:37.11237Z","caller":"traceutil/trace.go:171","msg":"trace[130345654] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:550; }","duration":"295.977282ms","start":"2026-04-29T15:17:36.816372Z","end":"2026-04-29T15:17:37.11235Z","steps":["trace[130345654] 'range keys from in-memory index tree' (duration: 295.580249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:37.11236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:36.805212Z","time spent":"307.137009ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-29T15:17:37.112525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.957124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:37.112706Z","caller":"traceutil/trace.go:171","msg":"trace[1351074841] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"217.189221ms","start":"2026-04-29T15:17:36.89547Z","end":"2026-04-29T15:17:37.112659Z","steps":["trace[1351074841] 'range keys from in-memory index tree' (duration: 216.296093ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:37.665473Z","caller":"traceutil/trace.go:171","msg":"trace[1101600970] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"548.07489ms","start":"2026-04-29T15:17:37.117375Z","end":"2026-04-29T15:17:37.66545Z","steps":["trace[1101600970] 'process raft request' (duration: 547.920455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:37.665615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:37.117352Z","time spent":"548.191574ms","remote":"127.0.0.1:50624","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-29T15:17:37.666213Z","caller":"traceutil/trace.go:171","msg":"trace[1320208790] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"548.02681ms","start":"2026-04-29T15:17:37.118161Z","end":"2026-04-29T15:17:37.666188Z","steps":["trace[1320208790] 'process raft request' (duration: 547.976578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:37.666396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:37.118152Z","time spent":"548.157714ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:17:37.666494Z","caller":"traceutil/trace.go:171","msg":"trace[1628129002] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"549.047643ms","start":"2026-04-29T15:17:37.117418Z","end":"2026-04-29T15:17:37.666466Z","steps":["trace[1628129002] 'process raft request' (duration: 548.615658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:37.666633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:37.117389Z","time spent":"549.170227ms","remote":"127.0.0.1:50624","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-29T15:17:41.396649Z","caller":"traceutil/trace.go:171","msg":"trace[877493628] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"174.048614ms","start":"2026-04-29T15:17:41.222568Z","end":"2026-04-29T15:17:41.396616Z","steps":["trace[877493628] 'process raft request' (duration: 173.477305ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:41.590857Z","caller":"traceutil/trace.go:171","msg":"trace[1810641775] linearizableReadLoop","detail":"{readStateIndex:600; appliedIndex:599; }","duration":"110.72335ms","start":"2026-04-29T15:17:41.480094Z","end":"2026-04-29T15:17:41.590818Z","steps":["trace[1810641775] 'read index received' (duration: 29.556362ms)","trace[1810641775] 'applied index is now lower than readState.Index' (duration: 81.165268ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:17:41.591414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.058542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:41.591524Z","caller":"traceutil/trace.go:171","msg":"trace[1938402381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:578; }","duration":"111.412863ms","start":"2026-04-29T15:17:41.480083Z","end":"2026-04-29T15:17:41.591496Z","steps":["trace[1938402381] 'agreement among raft nodes before linearized reading' (duration: 110.968539ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:41.592452Z","caller":"traceutil/trace.go:171","msg":"trace[84632671] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"129.089025ms","start":"2026-04-29T15:17:41.463324Z","end":"2026-04-29T15:17:41.592413Z","steps":["trace[84632671] 'process raft request' (duration: 46.435067ms)","trace[84632671] 'compare' (duration: 80.756275ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:17:41.592488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.378655ms","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-29T15:17:41.592573Z","caller":"traceutil/trace.go:171","msg":"trace[698606736] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:578; }","duration":"112.515059ms","start":"2026-04-29T15:17:41.480031Z","end":"2026-04-29T15:17:41.592546Z","steps":["trace[698606736] 'agreement among raft nodes before linearized reading' (duration: 112.367854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.602483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.495535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:17:42.602663Z","caller":"traceutil/trace.go:171","msg":"trace[379977574] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:600; }","duration":"839.413681ms","start":"2026-04-29T15:17:41.763192Z","end":"2026-04-29T15:17:42.602605Z","steps":["trace[379977574] 'read index received' (duration: 54.616226ms)","trace[379977574] 'applied index is now lower than readState.Index' (duration: 784.795835ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:17:42.602721Z","caller":"traceutil/trace.go:171","msg":"trace[1896676237] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"911.14729ms","start":"2026-04-29T15:17:41.691526Z","end":"2026-04-29T15:17:42.602673Z","steps":["trace[1896676237] 'process raft request' (duration: 126.350304ms)","trace[1896676237] 'compare' (duration: 784.301189ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:17:42.602938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.691501Z","time spent":"911.317445ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:17:42.602915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"839.69938ms","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-29T15:17:42.603021Z","caller":"traceutil/trace.go:171","msg":"trace[1137819080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:579; }","duration":"839.862876ms","start":"2026-04-29T15:17:41.763135Z","end":"2026-04-29T15:17:42.602998Z","steps":["trace[1137819080] 'agreement among raft nodes before linearized reading' (duration: 839.631479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.60308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.763105Z","time spent":"839.96468ms","remote":"127.0.0.1:50624","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":"info","ts":"2026-04-29T15:17:42.635836Z","caller":"traceutil/trace.go:171","msg":"trace[1747954339] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"607.410962ms","start":"2026-04-29T15:17:42.028393Z","end":"2026-04-29T15:17:42.635804Z","steps":["trace[1747954339] 'process raft request' (duration: 606.540683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.635946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.197326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:42.636152Z","caller":"traceutil/trace.go:171","msg":"trace[128823027] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:580; }","duration":"496.471504ms","start":"2026-04-29T15:17:42.139653Z","end":"2026-04-29T15:17:42.636125Z","steps":["trace[128823027] 'agreement among raft nodes before linearized reading' (duration: 496.183075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.636214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.139631Z","time spent":"496.567488ms","remote":"127.0.0.1:49028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:17:42.636357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.02836Z","time spent":"607.699972ms","remote":"127.0.0.1:50470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:17:42.636404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.814788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:42.636526Z","caller":"traceutil/trace.go:171","msg":"trace[130944242] 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:580; }","duration":"712.951523ms","start":"2026-04-29T15:17:41.923532Z","end":"2026-04-29T15:17:42.636484Z","steps":["trace[130944242] 'agreement among raft nodes before linearized reading' (duration: 712.761637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.636602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.923524Z","time spent":"713.043006ms","remote":"127.0.0.1:48990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"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\" limit:10000 "} {"level":"warn","ts":"2026-04-29T15:17:42.636781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"741.598895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:42.636872Z","caller":"traceutil/trace.go:171","msg":"trace[2100529738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"741.719039ms","start":"2026-04-29T15:17:41.89514Z","end":"2026-04-29T15:17:42.636859Z","steps":["trace[2100529738] 'agreement among raft nodes before linearized reading' (duration: 741.578054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.63696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.895132Z","time spent":"741.817742ms","remote":"127.0.0.1:50400","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-29T15:17:42.637016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.831672ms","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-29T15:17:42.637087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.920138ms","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":"info","ts":"2026-04-29T15:17:42.637129Z","caller":"traceutil/trace.go:171","msg":"trace[1387092306] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"342.994308ms","start":"2026-04-29T15:17:42.294122Z","end":"2026-04-29T15:17:42.637116Z","steps":["trace[1387092306] 'agreement among raft nodes before linearized reading' (duration: 342.856373ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.637144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.164728ms","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-29T15:17:42.637163Z","caller":"traceutil/trace.go:171","msg":"trace[228467827] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:580; }","duration":"323.056463ms","start":"2026-04-29T15:17:42.314087Z","end":"2026-04-29T15:17:42.637143Z","steps":["trace[228467827] 'agreement among raft nodes before linearized reading' (duration: 322.865447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.637178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.294097Z","time spent":"343.06421ms","remote":"127.0.0.1:49042","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"info","ts":"2026-04-29T15:17:42.637184Z","caller":"traceutil/trace.go:171","msg":"trace[925760729] 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:580; }","duration":"622.21769ms","start":"2026-04-29T15:17:42.014952Z","end":"2026-04-29T15:17:42.63717Z","steps":["trace[925760729] 'agreement among raft nodes before linearized reading' (duration: 622.162528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.637211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.314074Z","time spent":"323.126555ms","remote":"127.0.0.1:49044","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-29T15:17:42.637285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.014822Z","time spent":"622.418656ms","remote":"127.0.0.1:49020","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-29T15:17:42.637384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.858066ms","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-29T15:17:42.637428Z","caller":"traceutil/trace.go:171","msg":"trace[456255793] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"343.923689ms","start":"2026-04-29T15:17:42.293494Z","end":"2026-04-29T15:17:42.637417Z","steps":["trace[456255793] 'agreement among raft nodes before linearized reading' (duration: 343.860437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.637462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.293481Z","time spent":"343.97172ms","remote":"127.0.0.1:49042","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:17:42.637619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.678035ms","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-29T15:17:42.637653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.158806ms","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-29T15:17:42.637686Z","caller":"traceutil/trace.go:171","msg":"trace[1305958628] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:580; }","duration":"344.224248ms","start":"2026-04-29T15:17:42.293451Z","end":"2026-04-29T15:17:42.637676Z","steps":["trace[1305958628] 'agreement among raft nodes before linearized reading' (duration: 344.169907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.637726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.293433Z","time spent":"344.284711ms","remote":"127.0.0.1:49042","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/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-29T15:17:42.637738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.897312ms","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-29T15:17:42.637781Z","caller":"traceutil/trace.go:171","msg":"trace[278766418] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:580; }","duration":"157.948813ms","start":"2026-04-29T15:17:42.479819Z","end":"2026-04-29T15:17:42.637767Z","steps":["trace[278766418] 'agreement among raft nodes before linearized reading' (duration: 157.888411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.637852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.308225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:42.637674Z","caller":"traceutil/trace.go:171","msg":"trace[1240763035] 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:580; }","duration":"622.783378ms","start":"2026-04-29T15:17:42.014876Z","end":"2026-04-29T15:17:42.637659Z","steps":["trace[1240763035] 'agreement among raft nodes before linearized reading' (duration: 622.651704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.637964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.917285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:17:42.637971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.928056ms","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":"warn","ts":"2026-04-29T15:17:42.637974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.014855Z","time spent":"623.096779ms","remote":"127.0.0.1:49020","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-29T15:17:42.637993Z","caller":"traceutil/trace.go:171","msg":"trace[1970946838] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:580; }","duration":"373.948556ms","start":"2026-04-29T15:17:42.264036Z","end":"2026-04-29T15:17:42.637985Z","steps":["trace[1970946838] 'agreement among raft nodes before linearized reading' (duration: 373.904294ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:42.638014Z","caller":"traceutil/trace.go:171","msg":"trace[1204782004] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:580; }","duration":"159.010388ms","start":"2026-04-29T15:17:42.478991Z","end":"2026-04-29T15:17:42.638002Z","steps":["trace[1204782004] 'agreement among raft nodes before linearized reading' (duration: 158.945706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.638024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.263957Z","time spent":"374.05921ms","remote":"127.0.0.1:49030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-29T15:17:42.638174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.261236ms","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":"info","ts":"2026-04-29T15:17:42.638213Z","caller":"traceutil/trace.go:171","msg":"trace[1824089466] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:580; }","duration":"159.316499ms","start":"2026-04-29T15:17:42.478886Z","end":"2026-04-29T15:17:42.638202Z","steps":["trace[1824089466] 'agreement among raft nodes before linearized reading' (duration: 159.251737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.638227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.235652ms","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-29T15:17:42.638214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.252266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:17:42.63709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.609719ms","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":"warn","ts":"2026-04-29T15:17:42.638442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.53131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-04-29T15:17:42.638488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.856706ms","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-29T15:17:42.638531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.914778ms","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-29T15:17:42.638571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.980031ms","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":"warn","ts":"2026-04-29T15:17:42.638609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.051075ms","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":"warn","ts":"2026-04-29T15:17:42.638651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.464369ms","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":"warn","ts":"2026-04-29T15:17:42.639335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.823825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:42.640163Z","caller":"traceutil/trace.go:171","msg":"trace[1595192847] 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:580; }","duration":"715.658012ms","start":"2026-04-29T15:17:41.924487Z","end":"2026-04-29T15:17:42.640145Z","steps":["trace[1595192847] 'agreement among raft nodes before linearized reading' (duration: 714.813074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.640193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.306103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4vqj5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-29T15:17:42.640238Z","caller":"traceutil/trace.go:171","msg":"trace[1732863546] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4vqj5; range_end:; response_count:1; response_revision:580; }","duration":"827.384495ms","start":"2026-04-29T15:17:41.812841Z","end":"2026-04-29T15:17:42.640226Z","steps":["trace[1732863546] 'agreement among raft nodes before linearized reading' (duration: 827.281662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.640237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"818.662539ms","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-29T15:17:42.640283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.812818Z","time spent":"827.457438ms","remote":"127.0.0.1:50560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-4vqj5\" "} {"level":"info","ts":"2026-04-29T15:17:42.640286Z","caller":"traceutil/trace.go:171","msg":"trace[1502411836] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:580; }","duration":"818.724661ms","start":"2026-04-29T15:17:41.82155Z","end":"2026-04-29T15:17:42.640274Z","steps":["trace[1502411836] 'agreement among raft nodes before linearized reading' (duration: 818.654669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.640274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.92448Z","time spent":"715.739384ms","remote":"127.0.0.1:48990","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"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\" limit:500 "} {"level":"warn","ts":"2026-04-29T15:17:42.640328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.821528Z","time spent":"818.792023ms","remote":"127.0.0.1:48966","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-29T15:17:42.640463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"819.108944ms","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":"info","ts":"2026-04-29T15:17:42.640506Z","caller":"traceutil/trace.go:171","msg":"trace[1922081360] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:580; }","duration":"819.163335ms","start":"2026-04-29T15:17:41.821331Z","end":"2026-04-29T15:17:42.640495Z","steps":["trace[1922081360] 'agreement among raft nodes before linearized reading' (duration: 819.104723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.640539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.821323Z","time spent":"819.206676ms","remote":"127.0.0.1:48966","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-29T15:17:42.640583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.972575ms","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-29T15:17:42.640654Z","caller":"traceutil/trace.go:171","msg":"trace[523034571] 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:580; }","duration":"717.074848ms","start":"2026-04-29T15:17:41.923566Z","end":"2026-04-29T15:17:42.640641Z","steps":["trace[523034571] 'agreement among raft nodes before linearized reading' (duration: 716.924573ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:42.640669Z","caller":"traceutil/trace.go:171","msg":"trace[137712776] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:580; }","duration":"326.012109ms","start":"2026-04-29T15:17:42.314549Z","end":"2026-04-29T15:17:42.640561Z","steps":["trace[137712776] 'agreement among raft nodes before linearized reading' (duration: 324.039304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.640705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.923553Z","time spent":"717.140401ms","remote":"127.0.0.1:48990","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":"warn","ts":"2026-04-29T15:17:42.640721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.314528Z","time spent":"326.176695ms","remote":"127.0.0.1:49044","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":"info","ts":"2026-04-29T15:17:42.640431Z","caller":"traceutil/trace.go:171","msg":"trace[1808527570] 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:580; }","duration":"624.96651ms","start":"2026-04-29T15:17:42.015408Z","end":"2026-04-29T15:17:42.640374Z","steps":["trace[1808527570] 'agreement among raft nodes before linearized reading' (duration: 621.580109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.640795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.0154Z","time spent":"625.375633ms","remote":"127.0.0.1:49020","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":"info","ts":"2026-04-29T15:17:42.640851Z","caller":"traceutil/trace.go:171","msg":"trace[7760303] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"287.226645ms","start":"2026-04-29T15:17:42.353613Z","end":"2026-04-29T15:17:42.64084Z","steps":["trace[7760303] 'agreement among raft nodes before linearized reading' (duration: 284.848196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.63942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"655.932038ms","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-29T15:17:42.637919Z","caller":"traceutil/trace.go:171","msg":"trace[215675981] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:580; }","duration":"373.362857ms","start":"2026-04-29T15:17:42.264517Z","end":"2026-04-29T15:17:42.63788Z","steps":["trace[215675981] 'agreement among raft nodes before linearized reading' (duration: 373.307805ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:42.641033Z","caller":"traceutil/trace.go:171","msg":"trace[844328978] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"287.471583ms","start":"2026-04-29T15:17:42.353553Z","end":"2026-04-29T15:17:42.641024Z","steps":["trace[844328978] 'agreement among raft nodes before linearized reading' (duration: 284.996001ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:42.641048Z","caller":"traceutil/trace.go:171","msg":"trace[115804927] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"657.586723ms","start":"2026-04-29T15:17:41.983446Z","end":"2026-04-29T15:17:42.641032Z","steps":["trace[115804927] 'agreement among raft nodes before linearized reading' (duration: 655.913708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.641124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.98343Z","time spent":"657.674815ms","remote":"127.0.0.1:49006","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":"warn","ts":"2026-04-29T15:17:42.641159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.264504Z","time spent":"376.541901ms","remote":"127.0.0.1:49028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-29T15:17:42.636962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.343363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:42.641393Z","caller":"traceutil/trace.go:171","msg":"trace[1775750493] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:580; }","duration":"501.79493ms","start":"2026-04-29T15:17:42.139568Z","end":"2026-04-29T15:17:42.641363Z","steps":["trace[1775750493] 'agreement among raft nodes before linearized reading' (duration: 497.313842ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.639462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"745.333638ms","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-29T15:17:42.641448Z","caller":"traceutil/trace.go:171","msg":"trace[63068497] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:580; }","duration":"377.535984ms","start":"2026-04-29T15:17:42.2639Z","end":"2026-04-29T15:17:42.641436Z","steps":["trace[63068497] 'agreement among raft nodes before linearized reading' (duration: 374.286557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.641465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.139546Z","time spent":"501.901744ms","remote":"127.0.0.1:49028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-29T15:17:42.641435Z","caller":"traceutil/trace.go:171","msg":"trace[792483292] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:580; }","duration":"187.682211ms","start":"2026-04-29T15:17:42.452826Z","end":"2026-04-29T15:17:42.640509Z","steps":["trace[792483292] 'agreement among raft nodes before linearized reading' (duration: 185.495349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.64152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"878.209957ms","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-29T15:17:42.641567Z","caller":"traceutil/trace.go:171","msg":"trace[1746555069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"878.31476ms","start":"2026-04-29T15:17:41.763239Z","end":"2026-04-29T15:17:42.641554Z","steps":["trace[1746555069] 'agreement among raft nodes before linearized reading' (duration: 878.196586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.641597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.763197Z","time spent":"878.392913ms","remote":"127.0.0.1:50624","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-29T15:17:42.639486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.131745ms","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-29T15:17:42.641647Z","caller":"traceutil/trace.go:171","msg":"trace[1188529551] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"658.310587ms","start":"2026-04-29T15:17:41.983321Z","end":"2026-04-29T15:17:42.641632Z","steps":["trace[1188529551] 'agreement among raft nodes before linearized reading' (duration: 656.120185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.641698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.983303Z","time spent":"658.382708ms","remote":"127.0.0.1:49006","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-29T15:17:42.641494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.263871Z","time spent":"377.606287ms","remote":"127.0.0.1:49030","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-04-29T15:17:42.641766Z","caller":"traceutil/trace.go:171","msg":"trace[1268511004] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:580; }","duration":"327.55001ms","start":"2026-04-29T15:17:42.31414Z","end":"2026-04-29T15:17:42.64169Z","steps":["trace[1268511004] 'agreement among raft nodes before linearized reading' (duration: 324.48639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.639349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.662706ms","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":"warn","ts":"2026-04-29T15:17:42.639555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.823097ms","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-29T15:17:42.639573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.537199ms","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":"warn","ts":"2026-04-29T15:17:42.63961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.720554ms","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-29T15:17:42.639651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.840948ms","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-29T15:17:42.641002Z","caller":"traceutil/trace.go:171","msg":"trace[1318381605] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"287.38663ms","start":"2026-04-29T15:17:42.353605Z","end":"2026-04-29T15:17:42.640992Z","steps":["trace[1318381605] 'agreement among raft nodes before linearized reading' (duration: 284.902608ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:42.641406Z","caller":"traceutil/trace.go:171","msg":"trace[286055841] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"657.460469ms","start":"2026-04-29T15:17:41.983926Z","end":"2026-04-29T15:17:42.641387Z","steps":["trace[286055841] 'agreement among raft nodes before linearized reading' (duration: 654.265073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.641875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.983917Z","time spent":"657.943624ms","remote":"127.0.0.1:48994","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":"info","ts":"2026-04-29T15:17:42.641467Z","caller":"traceutil/trace.go:171","msg":"trace[1522709310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"747.356515ms","start":"2026-04-29T15:17:41.894095Z","end":"2026-04-29T15:17:42.641452Z","steps":["trace[1522709310] 'agreement among raft nodes before linearized reading' (duration: 745.330968ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.63951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.604209ms","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-29T15:17:42.64198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.894081Z","time spent":"747.889312ms","remote":"127.0.0.1:48986","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-29T15:17:42.641992Z","caller":"traceutil/trace.go:171","msg":"trace[816180859] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"749.109622ms","start":"2026-04-29T15:17:41.892872Z","end":"2026-04-29T15:17:42.641982Z","steps":["trace[816180859] 'agreement among raft nodes before linearized reading' (duration: 746.61366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.642019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.892826Z","time spent":"749.185834ms","remote":"127.0.0.1:48986","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":"info","ts":"2026-04-29T15:17:42.642099Z","caller":"traceutil/trace.go:171","msg":"trace[1495630206] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"687.089713ms","start":"2026-04-29T15:17:41.954997Z","end":"2026-04-29T15:17:42.642087Z","steps":["trace[1495630206] 'agreement among raft nodes before linearized reading' (duration: 684.553029ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.642137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.954978Z","time spent":"687.144974ms","remote":"127.0.0.1:48994","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-29T15:17:42.64221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.314131Z","time spent":"328.070347ms","remote":"127.0.0.1:49044","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-29T15:17:42.642235Z","caller":"traceutil/trace.go:171","msg":"trace[492118565] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"784.439943ms","start":"2026-04-29T15:17:41.857782Z","end":"2026-04-29T15:17:42.642222Z","steps":["trace[492118565] 'agreement among raft nodes before linearized reading' (duration: 781.849258ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:42.642251Z","caller":"traceutil/trace.go:171","msg":"trace[2007754220] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:580; }","duration":"820.617054ms","start":"2026-04-29T15:17:41.82162Z","end":"2026-04-29T15:17:42.642237Z","steps":["trace[2007754220] 'agreement among raft nodes before linearized reading' (duration: 817.639306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.642283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.857767Z","time spent":"784.500415ms","remote":"127.0.0.1:48982","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-29T15:17:42.642298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.821603Z","time spent":"820.680785ms","remote":"127.0.0.1:48966","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":"info","ts":"2026-04-29T15:17:42.642317Z","caller":"traceutil/trace.go:171","msg":"trace[2102853939] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"749.602708ms","start":"2026-04-29T15:17:41.892703Z","end":"2026-04-29T15:17:42.642305Z","steps":["trace[2102853939] 'agreement among raft nodes before linearized reading' (duration: 746.829336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.642345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.892692Z","time spent":"749.64398ms","remote":"127.0.0.1:48986","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":"info","ts":"2026-04-29T15:17:42.642361Z","caller":"traceutil/trace.go:171","msg":"trace[2041778433] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:580; }","duration":"784.501955ms","start":"2026-04-29T15:17:41.857851Z","end":"2026-04-29T15:17:42.642353Z","steps":["trace[2041778433] 'agreement among raft nodes before linearized reading' (duration: 781.723834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.642392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.857829Z","time spent":"784.554267ms","remote":"127.0.0.1:48982","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-29T15:17:42.639531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.467366ms","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-29T15:17:42.642532Z","caller":"traceutil/trace.go:171","msg":"trace[697938929] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"687.475415ms","start":"2026-04-29T15:17:41.955046Z","end":"2026-04-29T15:17:42.642521Z","steps":["trace[697938929] 'agreement among raft nodes before linearized reading' (duration: 684.459946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:42.642575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:41.955042Z","time spent":"687.515346ms","remote":"127.0.0.1:48994","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":"warn","ts":"2026-04-29T15:17:44.580968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.491005243s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:17:44.581182Z","caller":"traceutil/trace.go:171","msg":"trace[1579841979] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"1.933480462s","start":"2026-04-29T15:17:42.647666Z","end":"2026-04-29T15:17:44.581146Z","steps":["trace[1579841979] 'process raft request' (duration: 441.672872ms)","trace[1579841979] 'compare' (duration: 1.490869249s)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:17:44.581326Z","caller":"traceutil/trace.go:171","msg":"trace[1858997644] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"1.933564564s","start":"2026-04-29T15:17:42.647739Z","end":"2026-04-29T15:17:44.581304Z","steps":["trace[1858997644] 'process raft request' (duration: 1.933336156s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.581366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.647651Z","time spent":"1.933636276s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:17:44.581404Z","caller":"traceutil/trace.go:171","msg":"trace[842313964] linearizableReadLoop","detail":"{readStateIndex:606; appliedIndex:603; }","duration":"1.911986725s","start":"2026-04-29T15:17:42.66941Z","end":"2026-04-29T15:17:44.581396Z","steps":["trace[842313964] 'read index received' (duration: 419.947858ms)","trace[842313964] 'applied index is now lower than readState.Index' (duration: 1.492038257s)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:17:44.581435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.647733Z","time spent":"1.933640817s","remote":"127.0.0.1:50624","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-29T15:17:44.581367Z","caller":"traceutil/trace.go:171","msg":"trace[1103440816] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"1.913856146s","start":"2026-04-29T15:17:42.667492Z","end":"2026-04-29T15:17:44.581348Z","steps":["trace[1103440816] 'process raft request' (duration: 1.913644649s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.581534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.916213894s","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-29T15:17:44.58157Z","caller":"traceutil/trace.go:171","msg":"trace[876054624] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:585; }","duration":"1.916320747s","start":"2026-04-29T15:17:42.66524Z","end":"2026-04-29T15:17:44.58156Z","steps":["trace[876054624] 'agreement among raft nodes before linearized reading' (duration: 1.916238224s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.58161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.66522Z","time spent":"1.916380369s","remote":"127.0.0.1:49090","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-29T15:17:44.581635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.934531586s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:44.581668Z","caller":"traceutil/trace.go:171","msg":"trace[1912295774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:585; }","duration":"1.934597418s","start":"2026-04-29T15:17:42.64706Z","end":"2026-04-29T15:17:44.581657Z","steps":["trace[1912295774] 'agreement among raft nodes before linearized reading' (duration: 1.934534876s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.581702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.647041Z","time spent":"1.93465515s","remote":"127.0.0.1:50390","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-29T15:17:44.581569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.667479Z","time spent":"1.914061512s","remote":"127.0.0.1:50560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:17:44.581838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.899941979s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:44.581898Z","caller":"traceutil/trace.go:171","msg":"trace[674300012] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.900037182s","start":"2026-04-29T15:17:42.681849Z","end":"2026-04-29T15:17:44.581886Z","steps":["trace[674300012] 'agreement among raft nodes before linearized reading' (duration: 1.899929068s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.58192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.916737181s","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-29T15:17:44.581944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.681841Z","time spent":"1.900091893s","remote":"127.0.0.1:49102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"info","ts":"2026-04-29T15:17:44.581967Z","caller":"traceutil/trace.go:171","msg":"trace[1438579567] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:585; }","duration":"1.916782452s","start":"2026-04-29T15:17:42.665175Z","end":"2026-04-29T15:17:44.581957Z","steps":["trace[1438579567] 'agreement among raft nodes before linearized reading' (duration: 1.9167199s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.581982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.858829317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:17:44.581997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.858898629s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:17:44.582007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.665134Z","time spent":"1.916864416s","remote":"127.0.0.1:49090","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"info","ts":"2026-04-29T15:17:44.582014Z","caller":"traceutil/trace.go:171","msg":"trace[1142833606] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"1.858874118s","start":"2026-04-29T15:17:42.723131Z","end":"2026-04-29T15:17:44.582005Z","steps":["trace[1142833606] 'agreement among raft nodes before linearized reading' (duration: 1.858822186s)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:44.582034Z","caller":"traceutil/trace.go:171","msg":"trace[100341980] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"1.858974131s","start":"2026-04-29T15:17:42.723048Z","end":"2026-04-29T15:17:44.582023Z","steps":["trace[100341980] 'agreement among raft nodes before linearized reading' (duration: 1.8589237s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.582047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.723122Z","time spent":"1.85891608s","remote":"127.0.0.1:49128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:17:44.58207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.723028Z","time spent":"1.859033894s","remote":"127.0.0.1:49128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-04-29T15:17:44.582157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.900248099s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:17:44.581935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.88295137s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:44.582192Z","caller":"traceutil/trace.go:171","msg":"trace[2098051954] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.900283321s","start":"2026-04-29T15:17:42.6819Z","end":"2026-04-29T15:17:44.582184Z","steps":["trace[2098051954] 'agreement among raft nodes before linearized reading' (duration: 1.900236439s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.58222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.681857Z","time spent":"1.900354833s","remote":"127.0.0.1:49102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-04-29T15:17:44.581477Z","caller":"traceutil/trace.go:171","msg":"trace[752830269] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"1.857677199s","start":"2026-04-29T15:17:42.723768Z","end":"2026-04-29T15:17:44.581445Z","steps":["trace[752830269] 'process raft request' (duration: 1.857427571s)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:44.582209Z","caller":"traceutil/trace.go:171","msg":"trace[1734431183] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.883233499s","start":"2026-04-29T15:17:42.698959Z","end":"2026-04-29T15:17:44.582193Z","steps":["trace[1734431183] 'agreement among raft nodes before linearized reading' (duration: 1.882937159s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.582371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.88448798s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:17:44.582425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.884591524s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:17:44.582433Z","caller":"traceutil/trace.go:171","msg":"trace[603773221] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.884590133s","start":"2026-04-29T15:17:42.69783Z","end":"2026-04-29T15:17:44.58242Z","steps":["trace[603773221] 'agreement among raft nodes before linearized reading' (duration: 1.88449826s)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:44.582464Z","caller":"traceutil/trace.go:171","msg":"trace[828870657] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:585; }","duration":"1.884625175s","start":"2026-04-29T15:17:42.697825Z","end":"2026-04-29T15:17:44.58245Z","steps":["trace[828870657] 'agreement among raft nodes before linearized reading' (duration: 1.884575754s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.582478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.697795Z","time spent":"1.884669857s","remote":"127.0.0.1:49114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-04-29T15:17:44.582497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.697794Z","time spent":"1.884695758s","remote":"127.0.0.1:49114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:17:44.582521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.859341093s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:17:44.582372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.72375Z","time spent":"1.858593769s","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-29T15:17:44.58256Z","caller":"traceutil/trace.go:171","msg":"trace[112378242] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:585; }","duration":"1.859427047s","start":"2026-04-29T15:17:42.723123Z","end":"2026-04-29T15:17:44.58255Z","steps":["trace[112378242] 'agreement among raft nodes before linearized reading' (duration: 1.859370055s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.582599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.723096Z","time spent":"1.859494059s","remote":"127.0.0.1:49128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-04-29T15:17:44.581862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.916651878s","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":"info","ts":"2026-04-29T15:17:44.582676Z","caller":"traceutil/trace.go:171","msg":"trace[1427392324] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:585; }","duration":"1.917476786s","start":"2026-04-29T15:17:42.665191Z","end":"2026-04-29T15:17:44.582668Z","steps":["trace[1427392324] 'agreement among raft nodes before linearized reading' (duration: 1.916642428s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:17:44.582711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.665188Z","time spent":"1.917511667s","remote":"127.0.0.1:49090","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-29T15:17:44.582393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:42.698951Z","time spent":"1.883431576s","remote":"127.0.0.1:49102","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-04-29T15:17:45.061474Z","caller":"traceutil/trace.go:171","msg":"trace[1017370528] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"226.665693ms","start":"2026-04-29T15:17:44.83478Z","end":"2026-04-29T15:17:45.061445Z","steps":["trace[1017370528] 'process raft request' (duration: 226.433186ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:45.328286Z","caller":"traceutil/trace.go:171","msg":"trace[993916991] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"118.000231ms","start":"2026-04-29T15:17:45.210266Z","end":"2026-04-29T15:17:45.328266Z","steps":["trace[993916991] 'process raft request' (duration: 117.848836ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:17:45.452219Z","caller":"traceutil/trace.go:171","msg":"trace[381525520] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"139.312241ms","start":"2026-04-29T15:17:45.312878Z","end":"2026-04-29T15:17:45.45219Z","steps":["trace[381525520] 'process raft request' (duration: 114.66202ms)","trace[381525520] 'compare' (duration: 24.529287ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:17:46.337665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:17:46.025189Z","time spent":"312.472264ms","remote":"127.0.0.1:50406","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-29T15:18:01.262177Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114011507115567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-29T15:18:01.763228Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114011507115567,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-29T15:18:02.16487Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.351272248s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-29T15:18:02.508521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.29622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:18:02.508857Z","caller":"traceutil/trace.go:171","msg":"trace[279451932] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"1.753829154s","start":"2026-04-29T15:18:00.754812Z","end":"2026-04-29T15:18:02.508641Z","steps":["trace[279451932] 'process raft request' (duration: 1.410304506s)","trace[279451932] 'compare' (duration: 342.877245ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:18:02.508944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:00.754786Z","time spent":"1.754114455s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:18:02.522878Z","caller":"traceutil/trace.go:171","msg":"trace[1744334447] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"1.518329746s","start":"2026-04-29T15:18:01.004501Z","end":"2026-04-29T15:18:02.522831Z","steps":["trace[1744334447] 'process raft request' (duration: 1.518110729s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:02.523185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:01.004435Z","time spent":"1.518595216s","remote":"127.0.0.1:50598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:18:02.546012Z","caller":"traceutil/trace.go:171","msg":"trace[702266348] linearizableReadLoop","detail":"{readStateIndex:777; appliedIndex:774; }","duration":"1.78470187s","start":"2026-04-29T15:18:00.761281Z","end":"2026-04-29T15:18:02.545983Z","steps":["trace[702266348] 'read index received' (duration: 1.403858449s)","trace[702266348] 'applied index is now lower than readState.Index' (duration: 380.840271ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:18:02.546249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784961129s","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-29T15:18:02.546315Z","caller":"traceutil/trace.go:171","msg":"trace[2146979691] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:750; }","duration":"1.785061143s","start":"2026-04-29T15:18:00.76124Z","end":"2026-04-29T15:18:02.546301Z","steps":["trace[2146979691] 'agreement among raft nodes before linearized reading' (duration: 1.784839096s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:02.546317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691143348s","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-29T15:18:02.546353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:00.761225Z","time spent":"1.785120015s","remote":"127.0.0.1:50624","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":"info","ts":"2026-04-29T15:18:02.546379Z","caller":"traceutil/trace.go:171","msg":"trace[497548824] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:750; }","duration":"1.691263052s","start":"2026-04-29T15:18:00.855101Z","end":"2026-04-29T15:18:02.546364Z","steps":["trace[497548824] 'agreement among raft nodes before linearized reading' (duration: 1.691055444s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:02.546382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.650147905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:18:02.546426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:00.855076Z","time spent":"1.691339824s","remote":"127.0.0.1:50624","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-29T15:18:02.54648Z","caller":"traceutil/trace.go:171","msg":"trace[1171811303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:750; }","duration":"1.65027867s","start":"2026-04-29T15:18:00.896174Z","end":"2026-04-29T15:18:02.546453Z","steps":["trace[1171811303] 'agreement among raft nodes before linearized reading' (duration: 1.650082063s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:02.546527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:00.896159Z","time spent":"1.650359903s","remote":"127.0.0.1:50400","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-29T15:18:02.772618Z","caller":"traceutil/trace.go:171","msg":"trace[96267354] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"221.434681ms","start":"2026-04-29T15:18:02.551158Z","end":"2026-04-29T15:18:02.772593Z","steps":["trace[96267354] 'process raft request' (duration: 221.226624ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:02.779178Z","caller":"traceutil/trace.go:171","msg":"trace[802301971] linearizableReadLoop","detail":"{readStateIndex:779; appliedIndex:777; }","duration":"224.364455ms","start":"2026-04-29T15:18:02.554779Z","end":"2026-04-29T15:18:02.779144Z","steps":["trace[802301971] 'read index received' (duration: 217.601687ms)","trace[802301971] 'applied index is now lower than readState.Index' (duration: 6.761218ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:18:02.779486Z","caller":"traceutil/trace.go:171","msg":"trace[1895703815] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"227.225265ms","start":"2026-04-29T15:18:02.552248Z","end":"2026-04-29T15:18:02.779473Z","steps":["trace[1895703815] 'process raft request' (duration: 226.774449ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:02.779796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.991807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:18:02.779857Z","caller":"traceutil/trace.go:171","msg":"trace[334100249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"225.0934ms","start":"2026-04-29T15:18:02.554749Z","end":"2026-04-29T15:18:02.779842Z","steps":["trace[334100249] 'agreement among raft nodes before linearized reading' (duration: 224.984327ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:08.983417Z","caller":"traceutil/trace.go:171","msg":"trace[1881604275] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"131.960053ms","start":"2026-04-29T15:18:08.851432Z","end":"2026-04-29T15:18:08.983392Z","steps":["trace[1881604275] 'process raft request' (duration: 131.525818ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:08.988929Z","caller":"traceutil/trace.go:171","msg":"trace[527688528] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"135.586561ms","start":"2026-04-29T15:18:08.853305Z","end":"2026-04-29T15:18:08.988892Z","steps":["trace[527688528] 'process raft request' (duration: 135.308091ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:36.220383Z","caller":"traceutil/trace.go:171","msg":"trace[391512245] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:989; }","duration":"193.290031ms","start":"2026-04-29T15:18:36.027066Z","end":"2026-04-29T15:18:36.220356Z","steps":["trace[391512245] 'read index received' (duration: 192.999151ms)","trace[391512245] 'applied index is now lower than readState.Index' (duration: 289.83µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:18:36.220517Z","caller":"traceutil/trace.go:171","msg":"trace[1349707717] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"203.17543ms","start":"2026-04-29T15:18:36.017307Z","end":"2026-04-29T15:18:36.220482Z","steps":["trace[1349707717] 'process raft request' (duration: 202.876629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:36.220565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.066494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:18:36.220607Z","caller":"traceutil/trace.go:171","msg":"trace[1878883115] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:955; }","duration":"168.260701ms","start":"2026-04-29T15:18:36.05233Z","end":"2026-04-29T15:18:36.220591Z","steps":["trace[1878883115] 'agreement among raft nodes before linearized reading' (duration: 168.182528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:36.220724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.633754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-29T15:18:36.220821Z","caller":"traceutil/trace.go:171","msg":"trace[552815308] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:955; }","duration":"193.781769ms","start":"2026-04-29T15:18:36.027014Z","end":"2026-04-29T15:18:36.220795Z","steps":["trace[552815308] 'agreement among raft nodes before linearized reading' (duration: 193.479888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:37.312336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.925308ms","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-29T15:18:37.312422Z","caller":"traceutil/trace.go:171","msg":"trace[1337588365] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:962; }","duration":"166.060064ms","start":"2026-04-29T15:18:37.146343Z","end":"2026-04-29T15:18:37.312403Z","steps":["trace[1337588365] 'range keys from in-memory index tree' (duration: 165.713851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:37.312441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.147046ms","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-29T15:18:37.312505Z","caller":"traceutil/trace.go:171","msg":"trace[1234947015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:962; }","duration":"166.25051ms","start":"2026-04-29T15:18:37.14624Z","end":"2026-04-29T15:18:37.312491Z","steps":["trace[1234947015] 'range keys from in-memory index tree' (duration: 165.94371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:37.312489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.496839ms","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-29T15:18:37.31257Z","caller":"traceutil/trace.go:171","msg":"trace[2106602561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:962; }","duration":"193.619393ms","start":"2026-04-29T15:18:37.118926Z","end":"2026-04-29T15:18:37.312545Z","steps":["trace[2106602561] 'range keys from in-memory index tree' (duration: 193.327032ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:37.312766Z","caller":"traceutil/trace.go:171","msg":"trace[110923796] transaction","detail":"{read_only:false; response_revision:963; number_of_response:1; }","duration":"129.793817ms","start":"2026-04-29T15:18:37.182963Z","end":"2026-04-29T15:18:37.312756Z","steps":["trace[110923796] 'process raft request' (duration: 84.594897ms)","trace[110923796] 'compare' (duration: 45.095497ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:18:39.395124Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114011507116039,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-29T15:18:39.649162Z","caller":"traceutil/trace.go:171","msg":"trace[980883769] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"867.470575ms","start":"2026-04-29T15:18:38.781666Z","end":"2026-04-29T15:18:39.649137Z","steps":["trace[980883769] 'process raft request' (duration: 867.293308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:39.649383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:38.781655Z","time spent":"867.586629ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:18:39.741221Z","caller":"traceutil/trace.go:171","msg":"trace[881595094] linearizableReadLoop","detail":"{readStateIndex:1004; appliedIndex:1002; }","duration":"846.998515ms","start":"2026-04-29T15:18:38.894197Z","end":"2026-04-29T15:18:39.741196Z","steps":["trace[881595094] 'read index received' (duration: 754.837432ms)","trace[881595094] 'applied index is now lower than readState.Index' (duration: 92.160053ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:18:39.741435Z","caller":"traceutil/trace.go:171","msg":"trace[2129025449] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"423.372078ms","start":"2026-04-29T15:18:39.31798Z","end":"2026-04-29T15:18:39.741352Z","steps":["trace[2129025449] 'process raft request' (duration: 423.075078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:39.741628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.407552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-29T15:18:39.741642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"706.954376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-29T15:18:39.741664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.903137ms","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-29T15:18:39.741692Z","caller":"traceutil/trace.go:171","msg":"trace[776768450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:968; }","duration":"410.514826ms","start":"2026-04-29T15:18:39.331162Z","end":"2026-04-29T15:18:39.741677Z","steps":["trace[776768450] 'agreement among raft nodes before linearized reading' (duration: 410.332559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:39.741684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:39.317956Z","time spent":"423.605617ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:18:39.741712Z","caller":"traceutil/trace.go:171","msg":"trace[1924340041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:968; }","duration":"707.06493ms","start":"2026-04-29T15:18:39.034626Z","end":"2026-04-29T15:18:39.741691Z","steps":["trace[1924340041] 'agreement among raft nodes before linearized reading' (duration: 706.841112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:39.741781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"847.251863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:18:39.741835Z","caller":"traceutil/trace.go:171","msg":"trace[1660009013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:968; }","duration":"847.655638ms","start":"2026-04-29T15:18:38.894164Z","end":"2026-04-29T15:18:39.741819Z","steps":["trace[1660009013] 'agreement among raft nodes before linearized reading' (duration: 847.243833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:39.741724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:39.331147Z","time spent":"410.570647ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-29T15:18:39.741716Z","caller":"traceutil/trace.go:171","msg":"trace[2058637145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:968; }","duration":"349.041543ms","start":"2026-04-29T15:18:39.392659Z","end":"2026-04-29T15:18:39.741701Z","steps":["trace[2058637145] 'agreement among raft nodes before linearized reading' (duration: 348.828075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:39.741839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:39.034611Z","time spent":"707.211466ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-29T15:18:39.742018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:39.392638Z","time spent":"349.363333ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-29T15:18:39.741988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.813504ms","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-29T15:18:39.742637Z","caller":"traceutil/trace.go:171","msg":"trace[1177366286] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:968; }","duration":"349.510959ms","start":"2026-04-29T15:18:39.393116Z","end":"2026-04-29T15:18:39.742627Z","steps":["trace[1177366286] 'agreement among raft nodes before linearized reading' (duration: 348.634408ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:18:39.742671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:39.393101Z","time spent":"349.56026ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T15:18:39.742176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:18:38.894153Z","time spent":"847.71843ms","remote":"127.0.0.1:50400","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-29T15:18:51.939354Z","caller":"traceutil/trace.go:171","msg":"trace[1861138029] linearizableReadLoop","detail":"{readStateIndex:1047; appliedIndex:1046; }","duration":"122.108197ms","start":"2026-04-29T15:18:51.817224Z","end":"2026-04-29T15:18:51.939332Z","steps":["trace[1861138029] 'read index received' (duration: 42.844338ms)","trace[1861138029] 'applied index is now lower than readState.Index' (duration: 79.263229ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:18:51.939404Z","caller":"traceutil/trace.go:171","msg":"trace[143295334] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"156.224307ms","start":"2026-04-29T15:18:51.783151Z","end":"2026-04-29T15:18:51.939376Z","steps":["trace[143295334] 'process raft request' (duration: 76.988499ms)","trace[143295334] 'compare' (duration: 79.079613ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:18:51.939501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.265303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-29T15:18:51.939524Z","caller":"traceutil/trace.go:171","msg":"trace[253841027] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:1008; }","duration":"122.352965ms","start":"2026-04-29T15:18:51.817166Z","end":"2026-04-29T15:18:51.939518Z","steps":["trace[253841027] 'agreement among raft nodes before linearized reading' (duration: 122.277943ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:54.169018Z","caller":"traceutil/trace.go:171","msg":"trace[853791687] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"121.739234ms","start":"2026-04-29T15:18:54.047252Z","end":"2026-04-29T15:18:54.168991Z","steps":["trace[853791687] 'process raft request' (duration: 121.560758ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:54.169044Z","caller":"traceutil/trace.go:171","msg":"trace[1958923347] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"120.49861ms","start":"2026-04-29T15:18:54.048516Z","end":"2026-04-29T15:18:54.169015Z","steps":["trace[1958923347] 'process raft request' (duration: 120.395386ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:18:55.907853Z","caller":"traceutil/trace.go:171","msg":"trace[930487829] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"133.006361ms","start":"2026-04-29T15:18:55.774829Z","end":"2026-04-29T15:18:55.907836Z","steps":["trace[930487829] 'process raft request' (duration: 132.851115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:02.849026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.97878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-29T15:19:02.84913Z","caller":"traceutil/trace.go:171","msg":"trace[603568917] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1045; }","duration":"451.104963ms","start":"2026-04-29T15:19:02.397983Z","end":"2026-04-29T15:19:02.849088Z","steps":["trace[603568917] 'count revisions from in-memory index tree' (duration: 450.907367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:02.849186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:02.397961Z","time spent":"451.206867ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-04-29T15:19:04.158799Z","caller":"traceutil/trace.go:171","msg":"trace[628108642] linearizableReadLoop","detail":"{readStateIndex:1088; appliedIndex:1087; }","duration":"116.684353ms","start":"2026-04-29T15:19:04.04209Z","end":"2026-04-29T15:19:04.158774Z","steps":["trace[628108642] 'read index received' (duration: 105.817435ms)","trace[628108642] 'applied index is now lower than readState.Index' (duration: 10.866018ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:19:04.159016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.91016ms","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-29T15:19:04.159048Z","caller":"traceutil/trace.go:171","msg":"trace[101811927] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1047; }","duration":"116.993133ms","start":"2026-04-29T15:19:04.042044Z","end":"2026-04-29T15:19:04.159038Z","steps":["trace[101811927] 'agreement among raft nodes before linearized reading' (duration: 116.817057ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:04.159313Z","caller":"traceutil/trace.go:171","msg":"trace[513461015] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"145.158167ms","start":"2026-04-29T15:19:04.014119Z","end":"2026-04-29T15:19:04.159277Z","steps":["trace[513461015] 'process raft request' (duration: 133.833403ms)","trace[513461015] 'compare' (duration: 10.708763ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:06.245234Z","caller":"traceutil/trace.go:171","msg":"trace[214585350] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"182.076427ms","start":"2026-04-29T15:19:06.063132Z","end":"2026-04-29T15:19:06.245209Z","steps":["trace[214585350] 'process raft request' (duration: 181.917592ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:07.28424Z","caller":"traceutil/trace.go:171","msg":"trace[83467993] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"216.262536ms","start":"2026-04-29T15:19:07.067947Z","end":"2026-04-29T15:19:07.28421Z","steps":["trace[83467993] 'process raft request' (duration: 216.070429ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:08.419965Z","caller":"traceutil/trace.go:171","msg":"trace[1359431855] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"141.334597ms","start":"2026-04-29T15:19:08.278564Z","end":"2026-04-29T15:19:08.419898Z","steps":["trace[1359431855] 'read index received' (duration: 141.11764ms)","trace[1359431855] 'applied index is now lower than readState.Index' (duration: 215.867µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:08.42004Z","caller":"traceutil/trace.go:171","msg":"trace[1230462196] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"157.979991ms","start":"2026-04-29T15:19:08.262024Z","end":"2026-04-29T15:19:08.420004Z","steps":["trace[1230462196] 'process raft request' (duration: 157.735263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:08.420183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.606187ms","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-29T15:19:08.420223Z","caller":"traceutil/trace.go:171","msg":"trace[1747411802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1061; }","duration":"141.69372ms","start":"2026-04-29T15:19:08.278519Z","end":"2026-04-29T15:19:08.420213Z","steps":["trace[1747411802] 'agreement among raft nodes before linearized reading' (duration: 141.551185ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:08.52659Z","caller":"traceutil/trace.go:171","msg":"trace[1773781360] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"102.628097ms","start":"2026-04-29T15:19:08.423933Z","end":"2026-04-29T15:19:08.526561Z","steps":["trace[1773781360] 'process raft request' (duration: 72.31867ms)","trace[1773781360] 'compare' (duration: 30.1197ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:08.527139Z","caller":"traceutil/trace.go:171","msg":"trace[1948984043] transaction","detail":"{read_only:false; response_revision:1064; number_of_response:1; }","duration":"101.788048ms","start":"2026-04-29T15:19:08.425338Z","end":"2026-04-29T15:19:08.527126Z","steps":["trace[1948984043] 'process raft request' (duration: 101.184007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:20.73067Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114011507116483,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-29T15:19:21.026211Z","caller":"traceutil/trace.go:171","msg":"trace[1022282485] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"858.157158ms","start":"2026-04-29T15:19:20.16803Z","end":"2026-04-29T15:19:21.026188Z","steps":["trace[1022282485] 'process raft request' (duration: 857.978352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:21.026359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.168022Z","time spent":"858.257022ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:19:22.16689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.687967ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:19:22.167291Z","caller":"traceutil/trace.go:171","msg":"trace[1171497987] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"1.702398406s","start":"2026-04-29T15:19:20.464859Z","end":"2026-04-29T15:19:22.167257Z","steps":["trace[1171497987] 'process raft request' (duration: 848.248753ms)","trace[1171497987] 'compare' (duration: 853.504411ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:19:22.16745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.464837Z","time spent":"1.702534729s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:19:22.167487Z","caller":"traceutil/trace.go:171","msg":"trace[595491737] transaction","detail":"{read_only:false; response_revision:1152; number_of_response:1; }","duration":"1.462880133s","start":"2026-04-29T15:19:20.704582Z","end":"2026-04-29T15:19:22.167462Z","steps":["trace[595491737] 'process raft request' (duration: 1.462426547s)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:22.16753Z","caller":"traceutil/trace.go:171","msg":"trace[2074459470] linearizableReadLoop","detail":"{readStateIndex:1199; appliedIndex:1196; }","duration":"1.937020372s","start":"2026-04-29T15:19:20.230457Z","end":"2026-04-29T15:19:22.167477Z","steps":["trace[2074459470] 'read index received' (duration: 795.543417ms)","trace[2074459470] 'applied index is now lower than readState.Index' (duration: 1.141471185s)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:19:22.16761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.704557Z","time spent":"1.462987626s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:19:22.185958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.703120019s","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-29T15:19:22.185988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.955521679s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:19:22.186033Z","caller":"traceutil/trace.go:171","msg":"trace[1476911753] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1152; }","duration":"1.955590711s","start":"2026-04-29T15:19:20.230426Z","end":"2026-04-29T15:19:22.186017Z","steps":["trace[1476911753] 'agreement among raft nodes before linearized reading' (duration: 1.937128616s)","trace[1476911753] 'count revisions from in-memory index tree' (duration: 18.396343ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:22.186026Z","caller":"traceutil/trace.go:171","msg":"trace[649327591] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1152; }","duration":"1.703210623s","start":"2026-04-29T15:19:20.482797Z","end":"2026-04-29T15:19:22.186008Z","steps":["trace[649327591] 'agreement among raft nodes before linearized reading' (duration: 1.703035567s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:22.186059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.230413Z","time spent":"1.955639433s","remote":"127.0.0.1:49128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:19:22.186108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.48279Z","time spent":"1.703300185s","remote":"127.0.0.1:50624","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-29T15:19:22.186331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.605356638s","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-29T15:19:22.186367Z","caller":"traceutil/trace.go:171","msg":"trace[1899720321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1152; }","duration":"1.60540539s","start":"2026-04-29T15:19:20.580955Z","end":"2026-04-29T15:19:22.186361Z","steps":["trace[1899720321] 'agreement among raft nodes before linearized reading' (duration: 1.605294896s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:22.18639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.580952Z","time spent":"1.60543316s","remote":"127.0.0.1:50624","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-29T15:19:22.18642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.606098303s","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-29T15:19:22.186475Z","caller":"traceutil/trace.go:171","msg":"trace[1257151977] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1152; }","duration":"1.606173366s","start":"2026-04-29T15:19:20.580286Z","end":"2026-04-29T15:19:22.186459Z","steps":["trace[1257151977] 'agreement among raft nodes before linearized reading' (duration: 1.606056942s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:22.186515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.580274Z","time spent":"1.606233108s","remote":"127.0.0.1:50624","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-29T15:19:22.186667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.29039814s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:19:22.186699Z","caller":"traceutil/trace.go:171","msg":"trace[1542485159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1152; }","duration":"1.290466082s","start":"2026-04-29T15:19:20.896226Z","end":"2026-04-29T15:19:22.186692Z","steps":["trace[1542485159] 'agreement among raft nodes before linearized reading' (duration: 1.29041736s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:22.18672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.896207Z","time spent":"1.290509034s","remote":"127.0.0.1:50400","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-29T15:19:22.186284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.60452341s","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-29T15:19:22.187766Z","caller":"traceutil/trace.go:171","msg":"trace[378819956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1152; }","duration":"1.60602644s","start":"2026-04-29T15:19:20.581717Z","end":"2026-04-29T15:19:22.187744Z","steps":["trace[378819956] 'agreement among raft nodes before linearized reading' (duration: 1.604336083s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:22.187841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:20.58171Z","time spent":"1.606098683s","remote":"127.0.0.1:50624","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":"info","ts":"2026-04-29T15:19:34.334977Z","caller":"traceutil/trace.go:171","msg":"trace[1468933381] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"113.645869ms","start":"2026-04-29T15:19:34.221136Z","end":"2026-04-29T15:19:34.334782Z","steps":["trace[1468933381] 'process raft request' (duration: 113.477423ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:37.419102Z","caller":"traceutil/trace.go:171","msg":"trace[875115020] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"316.77174ms","start":"2026-04-29T15:19:37.102302Z","end":"2026-04-29T15:19:37.419074Z","steps":["trace[875115020] 'process raft request' (duration: 316.591024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:37.419251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:37.102268Z","time spent":"316.912765ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:19:38.181206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.204449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:19:38.181332Z","caller":"traceutil/trace.go:171","msg":"trace[1290767431] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1223; }","duration":"264.392145ms","start":"2026-04-29T15:19:37.916922Z","end":"2026-04-29T15:19:38.181314Z","steps":["trace[1290767431] 'count revisions from in-memory index tree' (duration: 264.061495ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:38.557623Z","caller":"traceutil/trace.go:171","msg":"trace[182767740] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"138.409158ms","start":"2026-04-29T15:19:38.419184Z","end":"2026-04-29T15:19:38.557593Z","steps":["trace[182767740] 'process raft request' (duration: 123.864035ms)","trace[182767740] 'compare' (duration: 14.405558ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:38.614875Z","caller":"traceutil/trace.go:171","msg":"trace[1241898873] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"194.795169ms","start":"2026-04-29T15:19:38.420063Z","end":"2026-04-29T15:19:38.614858Z","steps":["trace[1241898873] 'process raft request' (duration: 194.759238ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:38.614942Z","caller":"traceutil/trace.go:171","msg":"trace[1704064629] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"194.974675ms","start":"2026-04-29T15:19:38.419939Z","end":"2026-04-29T15:19:38.614914Z","steps":["trace[1704064629] 'process raft request' (duration: 194.84709ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:38.616365Z","caller":"traceutil/trace.go:171","msg":"trace[1957769483] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"195.393469ms","start":"2026-04-29T15:19:38.419649Z","end":"2026-04-29T15:19:38.615042Z","steps":["trace[1957769483] 'process raft request' (duration: 195.044917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:40.067577Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114011507116657,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-29T15:19:40.082327Z","caller":"traceutil/trace.go:171","msg":"trace[1647305750] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"515.609745ms","start":"2026-04-29T15:19:39.566697Z","end":"2026-04-29T15:19:40.082306Z","steps":["trace[1647305750] 'read index received' (duration: 515.415959ms)","trace[1647305750] 'applied index is now lower than readState.Index' (duration: 192.786µs)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:19:40.082476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.76773ms","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-29T15:19:40.082521Z","caller":"traceutil/trace.go:171","msg":"trace[347209452] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1231; }","duration":"515.863453ms","start":"2026-04-29T15:19:39.566645Z","end":"2026-04-29T15:19:40.082508Z","steps":["trace[347209452] 'agreement among raft nodes before linearized reading' (duration: 515.787241ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:40.082559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:39.566625Z","time spent":"515.923386ms","remote":"127.0.0.1:48952","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:19:40.082517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.57332ms","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":"info","ts":"2026-04-29T15:19:40.082697Z","caller":"traceutil/trace.go:171","msg":"trace[1937825615] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"654.192089ms","start":"2026-04-29T15:19:39.428438Z","end":"2026-04-29T15:19:40.08263Z","steps":["trace[1937825615] 'process raft request' (duration: 653.730414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:40.082871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:39.428426Z","time spent":"654.356285ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:19:40.082736Z","caller":"traceutil/trace.go:171","msg":"trace[422876978] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1231; }","duration":"496.83673ms","start":"2026-04-29T15:19:39.585887Z","end":"2026-04-29T15:19:40.082724Z","steps":["trace[422876978] 'agreement among raft nodes before linearized reading' (duration: 496.596551ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:40.082943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:39.585867Z","time spent":"497.061166ms","remote":"127.0.0.1:50704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:19:40.082909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.722799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-29T15:19:40.082739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.295388ms","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-29T15:19:40.083046Z","caller":"traceutil/trace.go:171","msg":"trace[1806296361] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1231; }","duration":"441.624719ms","start":"2026-04-29T15:19:39.641411Z","end":"2026-04-29T15:19:40.083036Z","steps":["trace[1806296361] 'agreement among raft nodes before linearized reading' (duration: 441.282718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:40.083092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:39.641342Z","time spent":"441.735863ms","remote":"127.0.0.1:49006","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-29T15:19:40.083005Z","caller":"traceutil/trace.go:171","msg":"trace[1390994833] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1231; }","duration":"484.858054ms","start":"2026-04-29T15:19:39.598135Z","end":"2026-04-29T15:19:40.082993Z","steps":["trace[1390994833] 'agreement among raft nodes before linearized reading' (duration: 484.630346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:40.08345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:39.598114Z","time spent":"485.302879ms","remote":"127.0.0.1:50692","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":55,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:19:41.064418Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114011507116660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-29T15:19:41.565392Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114011507116660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-29T15:19:41.690843Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.269971937s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-29T15:19:41.764344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.267467ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:19:41.764492Z","caller":"traceutil/trace.go:171","msg":"trace[1220701853] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1231; }","duration":"937.426953ms","start":"2026-04-29T15:19:40.827048Z","end":"2026-04-29T15:19:41.764475Z","steps":["trace[1220701853] 'range keys from in-memory index tree' (duration: 937.253847ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:41.764748Z","caller":"traceutil/trace.go:171","msg":"trace[2137547579] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"1.343948323s","start":"2026-04-29T15:19:40.420781Z","end":"2026-04-29T15:19:41.764729Z","steps":["trace[2137547579] 'process raft request' (duration: 1.270260337s)","trace[2137547579] 'compare' (duration: 72.976842ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:19:41.764849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:40.420758Z","time spent":"1.344028355s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:19:41.827723Z","caller":"traceutil/trace.go:171","msg":"trace[616768856] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"1.042430189s","start":"2026-04-29T15:19:40.785271Z","end":"2026-04-29T15:19:41.827701Z","steps":["trace[616768856] 'process raft request' (duration: 1.042278804s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:41.827872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:40.785253Z","time spent":"1.042533592s","remote":"127.0.0.1:50548","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5883,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-29T15:19:41.863098Z","caller":"traceutil/trace.go:171","msg":"trace[191732690] linearizableReadLoop","detail":"{readStateIndex:1285; appliedIndex:1282; }","duration":"1.299691164s","start":"2026-04-29T15:19:40.563357Z","end":"2026-04-29T15:19:41.863048Z","steps":["trace[191732690] 'read index received' (duration: 1.127704198s)","trace[191732690] 'applied index is now lower than readState.Index' (duration: 171.985206ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:19:41.863344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.299972473s","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-29T15:19:41.863402Z","caller":"traceutil/trace.go:171","msg":"trace[525226254] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1233; }","duration":"1.300086027s","start":"2026-04-29T15:19:40.563303Z","end":"2026-04-29T15:19:41.863389Z","steps":["trace[525226254] 'agreement among raft nodes before linearized reading' (duration: 1.29988649s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:41.86343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.244651949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-29T15:19:41.863445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:40.563284Z","time spent":"1.300152439s","remote":"127.0.0.1:50624","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":"info","ts":"2026-04-29T15:19:41.863476Z","caller":"traceutil/trace.go:171","msg":"trace[363297749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1233; }","duration":"1.244750513s","start":"2026-04-29T15:19:40.618712Z","end":"2026-04-29T15:19:41.863462Z","steps":["trace[363297749] 'agreement among raft nodes before linearized reading' (duration: 1.244548146s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:41.863543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:40.618699Z","time spent":"1.244833655s","remote":"127.0.0.1:50624","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-29T15:19:41.863825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242467006s","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-29T15:19:41.863864Z","caller":"traceutil/trace.go:171","msg":"trace[1771046690] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"1.242506697s","start":"2026-04-29T15:19:40.621348Z","end":"2026-04-29T15:19:41.863854Z","steps":["trace[1771046690] 'agreement among raft nodes before linearized reading' (duration: 1.242412604s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:41.863899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:40.621271Z","time spent":"1.24262162s","remote":"127.0.0.1:50624","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-29T15:19:41.863987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.243608454s","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-29T15:19:41.864043Z","caller":"traceutil/trace.go:171","msg":"trace[80630537] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1233; }","duration":"1.243690517s","start":"2026-04-29T15:19:40.620341Z","end":"2026-04-29T15:19:41.864032Z","steps":["trace[80630537] 'agreement among raft nodes before linearized reading' (duration: 1.243533442s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:41.864048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.013644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-29T15:19:41.864073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:40.620333Z","time spent":"1.243735078s","remote":"127.0.0.1:50624","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-29T15:19:41.864076Z","caller":"traceutil/trace.go:171","msg":"trace[1570577551] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1233; }","duration":"967.073107ms","start":"2026-04-29T15:19:40.896994Z","end":"2026-04-29T15:19:41.864067Z","steps":["trace[1570577551] 'agreement among raft nodes before linearized reading' (duration: 967.033706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:41.864101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:40.896974Z","time spent":"967.122308ms","remote":"127.0.0.1:50400","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-29T15:19:42.948057Z","caller":"traceutil/trace.go:171","msg":"trace[1322782877] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"234.42176ms","start":"2026-04-29T15:19:42.713609Z","end":"2026-04-29T15:19:42.948031Z","steps":["trace[1322782877] 'process raft request' (duration: 234.067148ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:43.968383Z","caller":"traceutil/trace.go:171","msg":"trace[1170463164] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"199.016452ms","start":"2026-04-29T15:19:43.769344Z","end":"2026-04-29T15:19:43.96836Z","steps":["trace[1170463164] 'process raft request' (duration: 198.766793ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:44.12683Z","caller":"traceutil/trace.go:171","msg":"trace[1525571379] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"154.187632ms","start":"2026-04-29T15:19:43.972612Z","end":"2026-04-29T15:19:44.1268Z","steps":["trace[1525571379] 'process raft request' (duration: 131.749032ms)","trace[1525571379] 'compare' (duration: 22.283905ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:44.127134Z","caller":"traceutil/trace.go:171","msg":"trace[175243132] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"152.046701ms","start":"2026-04-29T15:19:43.975056Z","end":"2026-04-29T15:19:44.127103Z","steps":["trace[175243132] 'process raft request' (duration: 151.700429ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:44.127658Z","caller":"traceutil/trace.go:171","msg":"trace[1021854853] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"152.550418ms","start":"2026-04-29T15:19:43.975087Z","end":"2026-04-29T15:19:44.127638Z","steps":["trace[1021854853] 'process raft request' (duration: 151.840434ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:51.824666Z","caller":"traceutil/trace.go:171","msg":"trace[1488217234] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"117.023493ms","start":"2026-04-29T15:19:51.707613Z","end":"2026-04-29T15:19:51.824636Z","steps":["trace[1488217234] 'process raft request' (duration: 116.850598ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.326874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431102066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:19:53.326955Z","caller":"traceutil/trace.go:171","msg":"trace[1587006108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"1.43122827s","start":"2026-04-29T15:19:51.895706Z","end":"2026-04-29T15:19:53.326934Z","steps":["trace[1587006108] 'range keys from in-memory index tree' (duration: 1.431008863s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.326996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:51.895687Z","time spent":"1.431299193s","remote":"127.0.0.1:50400","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-29T15:19:53.327448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.022882219s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:19:53.327515Z","caller":"traceutil/trace.go:171","msg":"trace[1596438584] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"1.267864567s","start":"2026-04-29T15:19:52.05964Z","end":"2026-04-29T15:19:53.327504Z","steps":["trace[1596438584] 'read index received' (duration: 244.832232ms)","trace[1596438584] 'applied index is now lower than readState.Index' (duration: 1.023031345s)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:53.327748Z","caller":"traceutil/trace.go:171","msg":"trace[1178396059] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"1.271933315s","start":"2026-04-29T15:19:52.055801Z","end":"2026-04-29T15:19:53.327735Z","steps":["trace[1178396059] 'process raft request' (duration: 248.699723ms)","trace[1178396059] 'compare' (duration: 1.022764966s)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:19:53.327849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.055773Z","time spent":"1.272041338s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-29T15:19:53.328056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268414655s","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-29T15:19:53.328091Z","caller":"traceutil/trace.go:171","msg":"trace[1954214312] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1309; }","duration":"1.268478168s","start":"2026-04-29T15:19:52.059604Z","end":"2026-04-29T15:19:53.328082Z","steps":["trace[1954214312] 'agreement among raft nodes before linearized reading' (duration: 1.268366634s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.32812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.05959Z","time spent":"1.268521639s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-29T15:19:53.329716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.166748162s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-29T15:19:53.329737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.168685078s","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-29T15:19:53.329838Z","caller":"traceutil/trace.go:171","msg":"trace[1599273130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1310; }","duration":"1.168808251s","start":"2026-04-29T15:19:52.161017Z","end":"2026-04-29T15:19:53.329825Z","steps":["trace[1599273130] 'agreement among raft nodes before linearized reading' (duration: 1.168582664s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.329905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.160945Z","time spent":"1.168949457s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-29T15:19:53.329939Z","caller":"traceutil/trace.go:171","msg":"trace[45268439] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"283.531374ms","start":"2026-04-29T15:19:53.046394Z","end":"2026-04-29T15:19:53.329925Z","steps":["trace[45268439] 'process raft request' (duration: 283.091819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.330102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.250518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-29T15:19:53.330145Z","caller":"traceutil/trace.go:171","msg":"trace[28829913] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1310; }","duration":"320.29171ms","start":"2026-04-29T15:19:53.00984Z","end":"2026-04-29T15:19:53.330132Z","steps":["trace[28829913] 'agreement among raft nodes before linearized reading' (duration: 320.193736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.330183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:53.009781Z","time spent":"320.394403ms","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-29T15:19:53.330282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.169500905s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-29T15:19:53.330381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131039742s","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-29T15:19:53.330359Z","caller":"traceutil/trace.go:171","msg":"trace[503267730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1310; }","duration":"1.169579978s","start":"2026-04-29T15:19:52.160769Z","end":"2026-04-29T15:19:53.330349Z","steps":["trace[503267730] 'agreement among raft nodes before linearized reading' (duration: 1.169369491s)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.330422Z","caller":"traceutil/trace.go:171","msg":"trace[1970612822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1310; }","duration":"1.131081073s","start":"2026-04-29T15:19:52.199331Z","end":"2026-04-29T15:19:53.330412Z","steps":["trace[1970612822] 'agreement among raft nodes before linearized reading' (duration: 1.13098043s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.330441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.160714Z","time spent":"1.169717073s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-29T15:19:53.330461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.199287Z","time spent":"1.131166287s","remote":"127.0.0.1:50624","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-29T15:19:53.330561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191338865s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-29T15:19:53.330621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.246564906s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-04-29T15:19:53.330637Z","caller":"traceutil/trace.go:171","msg":"trace[1863487597] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1310; }","duration":"1.191425658s","start":"2026-04-29T15:19:52.13919Z","end":"2026-04-29T15:19:53.330616Z","steps":["trace[1863487597] 'agreement among raft nodes before linearized reading' (duration: 1.191317274s)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.330655Z","caller":"traceutil/trace.go:171","msg":"trace[153188429] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1310; }","duration":"1.246643648s","start":"2026-04-29T15:19:52.084001Z","end":"2026-04-29T15:19:53.330645Z","steps":["trace[153188429] 'agreement among raft nodes before linearized reading' (duration: 1.246548565s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.330676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.139165Z","time spent":"1.19150073s","remote":"127.0.0.1:49008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":4,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-29T15:19:53.330688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.083971Z","time spent":"1.24670928s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-29T15:19:53.330821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.21892758s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-04-29T15:19:53.329777Z","caller":"traceutil/trace.go:171","msg":"trace[1667788348] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1310; }","duration":"1.166840905s","start":"2026-04-29T15:19:52.162922Z","end":"2026-04-29T15:19:53.329763Z","steps":["trace[1667788348] 'agreement among raft nodes before linearized reading' (duration: 1.166655589s)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.330858Z","caller":"traceutil/trace.go:171","msg":"trace[169786163] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1310; }","duration":"1.218991422s","start":"2026-04-29T15:19:52.111858Z","end":"2026-04-29T15:19:53.330849Z","steps":["trace[169786163] 'agreement among raft nodes before linearized reading' (duration: 1.218899569s)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.33087Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.162913Z","time spent":"1.167945952s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-29T15:19:53.330889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-29T15:19:52.11184Z","time spent":"1.219041693s","remote":"127.0.0.1:50624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":553,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-29T15:19:53.527382Z","caller":"traceutil/trace.go:171","msg":"trace[1267137163] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"193.013098ms","start":"2026-04-29T15:19:53.334338Z","end":"2026-04-29T15:19:53.527351Z","steps":["trace[1267137163] 'process raft request' (duration: 192.813102ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.533285Z","caller":"traceutil/trace.go:171","msg":"trace[1291304343] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"197.799211ms","start":"2026-04-29T15:19:53.335459Z","end":"2026-04-29T15:19:53.533258Z","steps":["trace[1291304343] 'process raft request' (duration: 196.8984ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.533448Z","caller":"traceutil/trace.go:171","msg":"trace[1790705268] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"196.977533ms","start":"2026-04-29T15:19:53.336446Z","end":"2026-04-29T15:19:53.533423Z","steps":["trace[1790705268] 'process raft request' (duration: 196.88436ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.53346Z","caller":"traceutil/trace.go:171","msg":"trace[1408620839] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"197.075606ms","start":"2026-04-29T15:19:53.336354Z","end":"2026-04-29T15:19:53.53343Z","steps":["trace[1408620839] 'process raft request' (duration: 196.828828ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.533676Z","caller":"traceutil/trace.go:171","msg":"trace[1211749518] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"197.030614ms","start":"2026-04-29T15:19:53.336605Z","end":"2026-04-29T15:19:53.533635Z","steps":["trace[1211749518] 'process raft request' (duration: 196.776696ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.533707Z","caller":"traceutil/trace.go:171","msg":"trace[1441036910] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"196.290699ms","start":"2026-04-29T15:19:53.337403Z","end":"2026-04-29T15:19:53.533694Z","steps":["trace[1441036910] 'process raft request' (duration: 196.129514ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.533721Z","caller":"traceutil/trace.go:171","msg":"trace[1661682684] linearizableReadLoop","detail":"{readStateIndex:1372; appliedIndex:1365; }","duration":"193.898939ms","start":"2026-04-29T15:19:53.3398Z","end":"2026-04-29T15:19:53.533699Z","steps":["trace[1661682684] 'read index received' (duration: 187.620836ms)","trace[1661682684] 'applied index is now lower than readState.Index' (duration: 6.277052ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:19:53.533745Z","caller":"traceutil/trace.go:171","msg":"trace[479416085] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"196.286509ms","start":"2026-04-29T15:19:53.337434Z","end":"2026-04-29T15:19:53.53372Z","steps":["trace[479416085] 'process raft request' (duration: 196.193646ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:19:53.533782Z","caller":"traceutil/trace.go:171","msg":"trace[1584393902] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"196.32077ms","start":"2026-04-29T15:19:53.337454Z","end":"2026-04-29T15:19:53.533775Z","steps":["trace[1584393902] 'process raft request' (duration: 196.208986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:19:53.533837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.019682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:19:53.533883Z","caller":"traceutil/trace.go:171","msg":"trace[950183838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1318; }","duration":"194.090995ms","start":"2026-04-29T15:19:53.339779Z","end":"2026-04-29T15:19:53.53387Z","steps":["trace[950183838] 'agreement among raft nodes before linearized reading' (duration: 194.000712ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:20:48.050163Z","caller":"traceutil/trace.go:171","msg":"trace[1666466675] transaction","detail":"{read_only:false; response_revision:1564; number_of_response:1; }","duration":"171.299663ms","start":"2026-04-29T15:20:47.878833Z","end":"2026-04-29T15:20:48.050132Z","steps":["trace[1666466675] 'process raft request' (duration: 171.122497ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:20:48.05042Z","caller":"traceutil/trace.go:171","msg":"trace[2130122258] transaction","detail":"{read_only:false; response_revision:1565; number_of_response:1; }","duration":"171.312193ms","start":"2026-04-29T15:20:47.879089Z","end":"2026-04-29T15:20:48.050401Z","steps":["trace[2130122258] 'process raft request' (duration: 170.983552ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:20:48.050579Z","caller":"traceutil/trace.go:171","msg":"trace[809878503] linearizableReadLoop","detail":"{readStateIndex:1631; appliedIndex:1627; }","duration":"154.269885ms","start":"2026-04-29T15:20:47.896295Z","end":"2026-04-29T15:20:48.050564Z","steps":["trace[809878503] 'read index received' (duration: 11.571832ms)","trace[809878503] 'applied index is now lower than readState.Index' (duration: 142.696303ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:20:48.050624Z","caller":"traceutil/trace.go:171","msg":"trace[853937200] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"170.879378ms","start":"2026-04-29T15:20:47.879732Z","end":"2026-04-29T15:20:48.050611Z","steps":["trace[853937200] 'process raft request' (duration: 170.590248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:20:48.050723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.410771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:20:48.050759Z","caller":"traceutil/trace.go:171","msg":"trace[1508039532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1566; }","duration":"154.506494ms","start":"2026-04-29T15:20:47.896242Z","end":"2026-04-29T15:20:48.050748Z","steps":["trace[1508039532] 'agreement among raft nodes before linearized reading' (duration: 154.368309ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:21:24.10892Z","caller":"traceutil/trace.go:171","msg":"trace[1095368213] linearizableReadLoop","detail":"{readStateIndex:1799; appliedIndex:1798; }","duration":"135.613743ms","start":"2026-04-29T15:21:23.973291Z","end":"2026-04-29T15:21:24.108905Z","steps":["trace[1095368213] 'read index received' (duration: 135.463008ms)","trace[1095368213] 'applied index is now lower than readState.Index' (duration: 150.165µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:21:24.108965Z","caller":"traceutil/trace.go:171","msg":"trace[1504368731] transaction","detail":"{read_only:false; response_revision:1727; number_of_response:1; }","duration":"144.686463ms","start":"2026-04-29T15:21:23.964255Z","end":"2026-04-29T15:21:24.108941Z","steps":["trace[1504368731] 'process raft request' (duration: 144.539459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:21:24.109044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.789109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-29T15:21:24.109063Z","caller":"traceutil/trace.go:171","msg":"trace[614104245] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1727; }","duration":"135.857201ms","start":"2026-04-29T15:21:23.973201Z","end":"2026-04-29T15:21:24.109058Z","steps":["trace[614104245] 'agreement among raft nodes before linearized reading' (duration: 135.791989ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:21:25.82282Z","caller":"traceutil/trace.go:171","msg":"trace[888686027] transaction","detail":"{read_only:false; response_revision:1735; number_of_response:1; }","duration":"103.692351ms","start":"2026-04-29T15:21:25.719096Z","end":"2026-04-29T15:21:25.822789Z","steps":["trace[888686027] 'process raft request' (duration: 103.543286ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:21:26.37658Z","caller":"traceutil/trace.go:171","msg":"trace[1563186847] transaction","detail":"{read_only:false; response_revision:1740; number_of_response:1; }","duration":"126.43928ms","start":"2026-04-29T15:21:26.250105Z","end":"2026-04-29T15:21:26.376545Z","steps":["trace[1563186847] 'process raft request' (duration: 39.394982ms)","trace[1563186847] 'compare' (duration: 86.81361ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:21:26.50893Z","caller":"traceutil/trace.go:171","msg":"trace[1941894040] transaction","detail":"{read_only:false; response_revision:1741; number_of_response:1; }","duration":"128.188065ms","start":"2026-04-29T15:21:26.380718Z","end":"2026-04-29T15:21:26.508906Z","steps":["trace[1941894040] 'process raft request' (duration: 110.327623ms)","trace[1941894040] 'compare' (duration: 17.764779ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:21:26.514118Z","caller":"traceutil/trace.go:171","msg":"trace[1790705706] transaction","detail":"{read_only:false; response_revision:1742; number_of_response:1; }","duration":"133.115952ms","start":"2026-04-29T15:21:26.380986Z","end":"2026-04-29T15:21:26.514102Z","steps":["trace[1790705706] 'process raft request' (duration: 133.024549ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:21:38.891425Z","caller":"traceutil/trace.go:171","msg":"trace[1771774213] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"115.028163ms","start":"2026-04-29T15:21:38.776378Z","end":"2026-04-29T15:21:38.891406Z","steps":["trace[1771774213] 'process raft request' (duration: 84.160114ms)","trace[1771774213] 'compare' (duration: 30.752445ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:22:02.721681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.928515ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:22:02.721792Z","caller":"traceutil/trace.go:171","msg":"trace[1158768575] linearizableReadLoop","detail":"{readStateIndex:1984; appliedIndex:1983; }","duration":"126.48015ms","start":"2026-04-29T15:22:02.595295Z","end":"2026-04-29T15:22:02.721776Z","steps":["trace[1158768575] 'read index received' (duration: 57.382µs)","trace[1158768575] 'applied index is now lower than readState.Index' (duration: 126.421648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:22:02.721918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.620905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-04-29T15:22:02.721949Z","caller":"traceutil/trace.go:171","msg":"trace[715480026] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1904; }","duration":"126.687256ms","start":"2026-04-29T15:22:02.595249Z","end":"2026-04-29T15:22:02.721937Z","steps":["trace[715480026] 'agreement among raft nodes before linearized reading' (duration: 126.571243ms)"],"step_count":1} {"level":"info","ts":"2026-04-29T15:22:02.721948Z","caller":"traceutil/trace.go:171","msg":"trace[961017462] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"186.346257ms","start":"2026-04-29T15:22:02.535541Z","end":"2026-04-29T15:22:02.721887Z","steps":["trace[961017462] 'process raft request' (duration: 39.110072ms)","trace[961017462] 'compare' (duration: 146.810111ms)"],"step_count":2} {"level":"warn","ts":"2026-04-29T15:22:02.97043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.862789ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-29T15:22:02.970632Z","caller":"traceutil/trace.go:171","msg":"trace[503319621] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"173.272468ms","start":"2026-04-29T15:22:02.797335Z","end":"2026-04-29T15:22:02.970608Z","steps":["trace[503319621] 'process raft request' (duration: 28.11179ms)","trace[503319621] 'compare' (duration: 144.739355ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:22:03.154337Z","caller":"traceutil/trace.go:171","msg":"trace[1767791585] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"105.200489ms","start":"2026-04-29T15:22:03.049113Z","end":"2026-04-29T15:22:03.154314Z","steps":["trace[1767791585] 'process raft request' (duration: 33.776602ms)","trace[1767791585] 'compare' (duration: 70.948472ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:22:37.096795Z","caller":"traceutil/trace.go:171","msg":"trace[201762430] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"129.496142ms","start":"2026-04-29T15:22:36.967269Z","end":"2026-04-29T15:22:37.096765Z","steps":["trace[201762430] 'process raft request' (duration: 91.196452ms)","trace[201762430] 'compare' (duration: 38.039522ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:22:37.2464Z","caller":"traceutil/trace.go:171","msg":"trace[677868506] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"114.432906ms","start":"2026-04-29T15:22:37.131923Z","end":"2026-04-29T15:22:37.246356Z","steps":["trace[677868506] 'process raft request' (duration: 80.21575ms)","trace[677868506] 'compare' (duration: 33.875815ms)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:23:06.125927Z","caller":"traceutil/trace.go:171","msg":"trace[914970220] linearizableReadLoop","detail":"{readStateIndex:2316; appliedIndex:2315; }","duration":"228.725958ms","start":"2026-04-29T15:23:05.897176Z","end":"2026-04-29T15:23:06.125902Z","steps":["trace[914970220] 'read index received' (duration: 228.446979ms)","trace[914970220] 'applied index is now lower than readState.Index' (duration: 277.479µs)"],"step_count":2} {"level":"info","ts":"2026-04-29T15:23:06.126006Z","caller":"traceutil/trace.go:171","msg":"trace[1465259762] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"287.655548ms","start":"2026-04-29T15:23:05.838299Z","end":"2026-04-29T15:23:06.125954Z","steps":["trace[1465259762] 'process raft request' (duration: 287.41821ms)"],"step_count":1} {"level":"warn","ts":"2026-04-29T15:23:06.126145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.955526ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-29T15:23:06.126192Z","caller":"traceutil/trace.go:171","msg":"trace[1799861899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2223; }","duration":"229.071349ms","start":"2026-04-29T15:23:05.89711Z","end":"2026-04-29T15:23:06.126181Z","steps":["trace[1799861899] 'agreement among raft nodes before linearized reading' (duration: 228.980286ms)"],"step_count":1}