{"level":"warn","ts":"2026-04-19T10:59:59.176012Z","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-19T10:59:59.176093Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.119: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.19.213.119:2380","--initial-cluster=instance=https://199.19.213.119:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.119:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.119: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-19T10:59:59.176155Z","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-19T10:59:59.176163Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.119:2380"]} {"level":"info","ts":"2026-04-19T10:59:59.176187Z","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-19T10:59:59.176728Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"]} {"level":"info","ts":"2026-04-19T10:59:59.176806Z","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.19.213.119:2380"],"listen-peer-urls":["https://199.19.213.119:2380"],"advertise-client-urls":["https://199.19.213.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.119: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-19T10:59:59.181909Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.917856ms"} {"level":"info","ts":"2026-04-19T10:59:59.191927Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ec9077c81c499df2","cluster-id":"7e82d3f5f740d3fb"} {"level":"info","ts":"2026-04-19T10:59:59.192057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=()"} {"level":"info","ts":"2026-04-19T10:59:59.192096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became follower at term 0"} {"level":"info","ts":"2026-04-19T10:59:59.19211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ec9077c81c499df2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-19T10:59:59.192121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became follower at term 1"} {"level":"info","ts":"2026-04-19T10:59:59.192178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=(17046256290949078514)"} {"level":"warn","ts":"2026-04-19T10:59:59.197218Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-19T10:59:59.199037Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-19T10:59:59.200258Z","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-19T10:59:59.202111Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ec9077c81c499df2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-19T10:59:59.202355Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ec9077c81c499df2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-19T10:59:59.202564Z","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-19T10:59:59.202635Z","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-19T10:59:59.203175Z","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-19T10:59:59.205073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 switched to configuration voters=(17046256290949078514)"} {"level":"info","ts":"2026-04-19T10:59:59.205164Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7e82d3f5f740d3fb","local-member-id":"ec9077c81c499df2","added-peer-id":"ec9077c81c499df2","added-peer-peer-urls":["https://199.19.213.119:2380"]} {"level":"info","ts":"2026-04-19T10:59:59.20638Z","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-19T10:59:59.206507Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.119:2380"} {"level":"info","ts":"2026-04-19T10:59:59.206566Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.119:2380"} {"level":"info","ts":"2026-04-19T10:59:59.206624Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ec9077c81c499df2","initial-advertise-peer-urls":["https://199.19.213.119:2380"],"listen-peer-urls":["https://199.19.213.119:2380"],"advertise-client-urls":["https://199.19.213.119:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.119:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-19T10:59:59.206669Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-19T10:59:59.992959Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 is starting a new election at term 1"} {"level":"info","ts":"2026-04-19T10:59:59.993062Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-19T10:59:59.993091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 received MsgPreVoteResp from ec9077c81c499df2 at term 1"} {"level":"info","ts":"2026-04-19T10:59:59.99311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became candidate at term 2"} {"level":"info","ts":"2026-04-19T10:59:59.993116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 received MsgVoteResp from ec9077c81c499df2 at term 2"} {"level":"info","ts":"2026-04-19T10:59:59.993129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ec9077c81c499df2 became leader at term 2"} {"level":"info","ts":"2026-04-19T10:59:59.99314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ec9077c81c499df2 elected leader ec9077c81c499df2 at term 2"} {"level":"info","ts":"2026-04-19T10:59:59.994436Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T10:59:59.994946Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T10:59:59.994935Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-19T10:59:59.994922Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ec9077c81c499df2","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.119:2379]}","request-path":"/0/members/ec9077c81c499df2/attributes","cluster-id":"7e82d3f5f740d3fb","publish-timeout":"7s"} {"level":"info","ts":"2026-04-19T10:59:59.995366Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-19T10:59:59.995398Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-19T10:59:59.995678Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7e82d3f5f740d3fb","local-member-id":"ec9077c81c499df2","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T10:59:59.995878Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T10:59:59.995957Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-19T10:59:59.99779Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-19T10:59:59.998815Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.119:2379"} {"level":"warn","ts":"2026-04-19T11:00:03.510449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.667963ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:00:03.510601Z","caller":"traceutil/trace.go:171","msg":"trace[1242412108] transaction","detail":"{read_only:false; response_revision:191; number_of_response:1; }","duration":"636.407723ms","start":"2026-04-19T11:00:02.874164Z","end":"2026-04-19T11:00:03.510572Z","steps":["trace[1242412108] 'process raft request' (duration: 313.888329ms)","trace[1242412108] 'compare' (duration: 321.504661ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:03.510764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:02.874153Z","time spent":"636.563205ms","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":838,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:03.510593Z","caller":"traceutil/trace.go:171","msg":"trace[1200771225] linearizableReadLoop","detail":"{readStateIndex:195; appliedIndex:194; }","duration":"246.894383ms","start":"2026-04-19T11:00:03.26368Z","end":"2026-04-19T11:00:03.510574Z","steps":["trace[1200771225] 'read index received' (duration: 77.161µs)","trace[1200771225] 'applied index is now lower than readState.Index' (duration: 246.815472ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:03.511039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.355999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:03.511192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.050547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-19T11:00:03.511191Z","caller":"traceutil/trace.go:171","msg":"trace[1887004768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:191; }","duration":"247.566182ms","start":"2026-04-19T11:00:03.263608Z","end":"2026-04-19T11:00:03.511174Z","steps":["trace[1887004768] 'agreement among raft nodes before linearized reading' (duration: 247.252818ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:03.511279Z","caller":"traceutil/trace.go:171","msg":"trace[28069740] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:191; }","duration":"159.173199ms","start":"2026-04-19T11:00:03.352086Z","end":"2026-04-19T11:00:03.511259Z","steps":["trace[28069740] 'agreement among raft nodes before linearized reading' (duration: 159.007077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:04.385715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"711.012087ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:00:04.38581Z","caller":"traceutil/trace.go:171","msg":"trace[161217346] linearizableReadLoop","detail":"{readStateIndex:197; appliedIndex:195; }","duration":"869.683328ms","start":"2026-04-19T11:00:03.516113Z","end":"2026-04-19T11:00:04.385796Z","steps":["trace[161217346] 'read index received' (duration: 77.403256ms)","trace[161217346] 'applied index is now lower than readState.Index' (duration: 792.278952ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:04.385885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.77071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-19T11:00:04.385906Z","caller":"traceutil/trace.go:171","msg":"trace[1886326104] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:193; }","duration":"869.81664ms","start":"2026-04-19T11:00:03.516081Z","end":"2026-04-19T11:00:04.385897Z","steps":["trace[1886326104] 'agreement among raft nodes before linearized reading' (duration: 869.770289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:04.385931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:03.516071Z","time spent":"869.85424ms","remote":"127.0.0.1:54060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-19T11:00:04.385902Z","caller":"traceutil/trace.go:171","msg":"trace[488498506] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"869.990392ms","start":"2026-04-19T11:00:03.515842Z","end":"2026-04-19T11:00:04.385832Z","steps":["trace[488498506] 'process raft request' (duration: 158.662821ms)","trace[488498506] 'compare' (duration: 710.892785ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:04.386082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:03.515818Z","time spent":"870.165795ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:05.896279Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.213036672s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-19T11:00:05.988434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.305835214s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:00:05.988764Z","caller":"traceutil/trace.go:171","msg":"trace[1883245842] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"1.599567677s","start":"2026-04-19T11:00:04.389171Z","end":"2026-04-19T11:00:05.988739Z","steps":["trace[1883245842] 'process raft request' (duration: 1.599382774s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:05.988854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:04.389151Z","time spent":"1.599663198s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":793,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:05.989134Z","caller":"traceutil/trace.go:171","msg":"trace[479483853] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"2.068145491s","start":"2026-04-19T11:00:03.920969Z","end":"2026-04-19T11:00:05.989115Z","steps":["trace[479483853] 'process raft request' (duration: 761.545136ms)","trace[479483853] 'compare' (duration: 1.304963613s)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:05.989207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:03.92095Z","time spent":"2.068225472s","remote":"127.0.0.1:54114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:05.989254Z","caller":"traceutil/trace.go:171","msg":"trace[1727951749] linearizableReadLoop","detail":"{readStateIndex:198; appliedIndex:197; }","duration":"1.603386959s","start":"2026-04-19T11:00:04.385827Z","end":"2026-04-19T11:00:05.989214Z","steps":["trace[1727951749] 'read index received' (duration: 297.472745ms)","trace[1727951749] 'applied index is now lower than readState.Index' (duration: 1.305911264s)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:05.989397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.104158347s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:05.989385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.679422945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:05.989436Z","caller":"traceutil/trace.go:171","msg":"trace[176351563] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:195; }","duration":"2.104219287s","start":"2026-04-19T11:00:03.885197Z","end":"2026-04-19T11:00:05.989416Z","steps":["trace[176351563] 'agreement among raft nodes before linearized reading' (duration: 2.104166186s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:05.989454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:03.885179Z","time spent":"2.104271079s","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-19T11:00:05.989448Z","caller":"traceutil/trace.go:171","msg":"trace[6086009] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:195; }","duration":"1.679526746s","start":"2026-04-19T11:00:04.309903Z","end":"2026-04-19T11:00:05.98943Z","steps":["trace[6086009] 'agreement among raft nodes before linearized reading' (duration: 1.679379734s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:05.989495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:04.309882Z","time spent":"1.679601258s","remote":"127.0.0.1:53932","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-19T11:00:06.489865Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381332542020147676,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-19T11:00:06.749921Z","caller":"traceutil/trace.go:171","msg":"trace[1069585408] transaction","detail":"{read_only:false; response_revision:196; number_of_response:1; }","duration":"905.671069ms","start":"2026-04-19T11:00:05.844228Z","end":"2026-04-19T11:00:06.749899Z","steps":["trace[1069585408] 'process raft request' (duration: 887.824239ms)","trace[1069585408] 'compare' (duration: 17.623597ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:06.750028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:05.844186Z","time spent":"905.792291ms","remote":"127.0.0.1:54114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:06.753462Z","caller":"traceutil/trace.go:171","msg":"trace[565627342] linearizableReadLoop","detail":"{readStateIndex:201; appliedIndex:199; }","duration":"764.103731ms","start":"2026-04-19T11:00:05.989339Z","end":"2026-04-19T11:00:06.753443Z","steps":["trace[565627342] 'read index received' (duration: 742.925535ms)","trace[565627342] 'applied index is now lower than readState.Index' (duration: 21.177366ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:06.753576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.17235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:06.753615Z","caller":"traceutil/trace.go:171","msg":"trace[1105256019] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:197; }","duration":"970.276052ms","start":"2026-04-19T11:00:05.783325Z","end":"2026-04-19T11:00:06.753602Z","steps":["trace[1105256019] 'agreement among raft nodes before linearized reading' (duration: 970.215771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:06.753655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:05.783294Z","time spent":"970.353473ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-19T11:00:06.75372Z","caller":"traceutil/trace.go:171","msg":"trace[1422649075] transaction","detail":"{read_only:false; response_revision:197; number_of_response:1; }","duration":"760.677635ms","start":"2026-04-19T11:00:05.993024Z","end":"2026-04-19T11:00:06.753702Z","steps":["trace[1422649075] 'process raft request' (duration: 760.267439ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:06.753749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.325809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:06.75378Z","caller":"traceutil/trace.go:171","msg":"trace[1263362765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:197; }","duration":"989.384149ms","start":"2026-04-19T11:00:05.764387Z","end":"2026-04-19T11:00:06.753772Z","steps":["trace[1263362765] 'agreement among raft nodes before linearized reading' (duration: 989.342989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:06.753807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:05.993007Z","time spent":"760.757826ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T11:00:06.753813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:05.764335Z","time spent":"989.472961ms","remote":"127.0.0.1:53932","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-19T11:00:06.75389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.540191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:06.753929Z","caller":"traceutil/trace.go:171","msg":"trace[489161813] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:197; }","duration":"762.619281ms","start":"2026-04-19T11:00:05.991302Z","end":"2026-04-19T11:00:06.753921Z","steps":["trace[489161813] 'agreement among raft nodes before linearized reading' (duration: 762.5636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:06.753938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.539571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-19T11:00:06.753949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:05.991283Z","time spent":"762.661941ms","remote":"127.0.0.1:53940","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-19T11:00:06.753957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"761.899321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system:controller:bootstrap-signer\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:06.753967Z","caller":"traceutil/trace.go:171","msg":"trace[1158668728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:197; }","duration":"363.609552ms","start":"2026-04-19T11:00:06.39035Z","end":"2026-04-19T11:00:06.753959Z","steps":["trace[1158668728] 'agreement among raft nodes before linearized reading' (duration: 363.539411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:06.753986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:06.390329Z","time spent":"363.653722ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-19T11:00:06.753983Z","caller":"traceutil/trace.go:171","msg":"trace[1041744247] range","detail":"{range_begin:/registry/rolebindings/kube-system/system:controller:bootstrap-signer; range_end:; response_count:0; response_revision:197; }","duration":"761.989622ms","start":"2026-04-19T11:00:05.991984Z","end":"2026-04-19T11:00:06.753974Z","steps":["trace[1041744247] 'agreement among raft nodes before linearized reading' (duration: 761.951681ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:06.754003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:05.991977Z","time spent":"762.021132ms","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/kube-system/system:controller:bootstrap-signer\" "} {"level":"warn","ts":"2026-04-19T11:00:06.754054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155908486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-19T11:00:06.754111Z","caller":"traceutil/trace.go:171","msg":"trace[1485149819] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:197; }","duration":"1.156015746s","start":"2026-04-19T11:00:05.598079Z","end":"2026-04-19T11:00:06.754095Z","steps":["trace[1485149819] 'agreement among raft nodes before linearized reading' (duration: 1.155890945s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:06.754143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:05.598059Z","time spent":"1.156078227s","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T11:00:10.70609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.639738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:10.706178Z","caller":"traceutil/trace.go:171","msg":"trace[1763439307] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:0; response_revision:336; }","duration":"134.783635ms","start":"2026-04-19T11:00:10.571378Z","end":"2026-04-19T11:00:10.706161Z","steps":["trace[1763439307] 'range keys from in-memory index tree' (duration: 134.511734ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:12.689176Z","caller":"traceutil/trace.go:171","msg":"trace[1789801077] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:366; }","duration":"164.66528ms","start":"2026-04-19T11:00:12.524428Z","end":"2026-04-19T11:00:12.689094Z","steps":["trace[1789801077] 'read index received' (duration: 164.39031ms)","trace[1789801077] 'applied index is now lower than readState.Index' (duration: 273.24µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:12.689323Z","caller":"traceutil/trace.go:171","msg":"trace[1434789254] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"206.994267ms","start":"2026-04-19T11:00:12.482307Z","end":"2026-04-19T11:00:12.689302Z","steps":["trace[1434789254] 'process raft request' (duration: 206.493889ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:12.689599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.282577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-19T11:00:12.689689Z","caller":"traceutil/trace.go:171","msg":"trace[1531476734] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:352; }","duration":"113.442903ms","start":"2026-04-19T11:00:12.576225Z","end":"2026-04-19T11:00:12.689668Z","steps":["trace[1531476734] 'agreement among raft nodes before linearized reading' (duration: 113.189273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:12.689978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.219463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-19T11:00:12.690106Z","caller":"traceutil/trace.go:171","msg":"trace[358955530] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"117.444301ms","start":"2026-04-19T11:00:12.572643Z","end":"2026-04-19T11:00:12.690087Z","steps":["trace[358955530] 'agreement among raft nodes before linearized reading' (duration: 116.762695ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.375078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.722698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-05xbpc\" ","response":"range_response_count:1 size:540"} {"level":"warn","ts":"2026-04-19T11:00:13.375189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.787416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4197"} {"level":"info","ts":"2026-04-19T11:00:13.375332Z","caller":"traceutil/trace.go:171","msg":"trace[1083223267] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:352; }","duration":"681.985443ms","start":"2026-04-19T11:00:12.693313Z","end":"2026-04-19T11:00:13.375299Z","steps":["trace[1083223267] 'range keys from in-memory index tree' (duration: 681.698932ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:13.37525Z","caller":"traceutil/trace.go:171","msg":"trace[1510966299] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-05xbpc; range_end:; response_count:1; response_revision:352; }","duration":"798.901255ms","start":"2026-04-19T11:00:12.576301Z","end":"2026-04-19T11:00:13.375202Z","steps":["trace[1510966299] 'agreement among raft nodes before linearized reading' (duration: 113.223866ms)","trace[1510966299] 'range keys from in-memory index tree' (duration: 685.483092ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:13.375411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.693298Z","time spent":"682.103497ms","remote":"127.0.0.1:54110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4220,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-19T11:00:13.37508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"850.62673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-19T11:00:13.375631Z","caller":"traceutil/trace.go:171","msg":"trace[1710754411] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:352; }","duration":"851.245463ms","start":"2026-04-19T11:00:12.524369Z","end":"2026-04-19T11:00:13.375614Z","steps":["trace[1710754411] 'agreement among raft nodes before linearized reading' (duration: 165.098266ms)","trace[1710754411] 'range keys from in-memory index tree' (duration: 685.499394ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:13.375127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.701241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-04-19T11:00:13.375768Z","caller":"traceutil/trace.go:171","msg":"trace[1023125277] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:352; }","duration":"703.389786ms","start":"2026-04-19T11:00:12.672351Z","end":"2026-04-19T11:00:13.37574Z","steps":["trace[1023125277] 'agreement among raft nodes before linearized reading' (duration: 17.215248ms)","trace[1023125277] 'range keys from in-memory index tree' (duration: 685.493773ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:13.375832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.672285Z","time spent":"703.532101ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-04-19T11:00:13.375784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.524339Z","time spent":"851.387048ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-04-19T11:00:13.375631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.687387ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"warn","ts":"2026-04-19T11:00:13.37548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.576289Z","time spent":"799.170104ms","remote":"127.0.0.1:54048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":563,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-05xbpc\" "} {"level":"warn","ts":"2026-04-19T11:00:13.375072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.901185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-04-19T11:00:13.376222Z","caller":"traceutil/trace.go:171","msg":"trace[988998168] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:367; }","duration":"653.24576ms","start":"2026-04-19T11:00:12.72296Z","end":"2026-04-19T11:00:13.376206Z","steps":["trace[988998168] 'read index received' (duration: 273.814065ms)","trace[988998168] 'applied index is now lower than readState.Index' (duration: 379.430885ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:13.37623Z","caller":"traceutil/trace.go:171","msg":"trace[613059174] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:352; }","duration":"800.11228ms","start":"2026-04-19T11:00:12.576097Z","end":"2026-04-19T11:00:13.37621Z","steps":["trace[613059174] 'agreement among raft nodes before linearized reading' (duration: 113.443763ms)","trace[613059174] 'range keys from in-memory index tree' (duration: 685.42953ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:13.376285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.576084Z","time spent":"800.186082ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":559,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-04-19T11:00:13.376313Z","caller":"traceutil/trace.go:171","msg":"trace[5711524] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"682.220382ms","start":"2026-04-19T11:00:12.69408Z","end":"2026-04-19T11:00:13.376301Z","steps":["trace[5711524] 'process raft request' (duration: 302.683083ms)","trace[5711524] 'compare' (duration: 378.20211ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:13.376374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.694068Z","time spent":"682.273105ms","remote":"127.0.0.1:54024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:13.376426Z","caller":"traceutil/trace.go:171","msg":"trace[849076892] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"677.533518ms","start":"2026-04-19T11:00:12.698873Z","end":"2026-04-19T11:00:13.376407Z","steps":["trace[849076892] 'process raft request' (duration: 677.252248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.376664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.709506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-04-19T11:00:13.376724Z","caller":"traceutil/trace.go:171","msg":"trace[745920477] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:356; }","duration":"653.82519ms","start":"2026-04-19T11:00:12.722884Z","end":"2026-04-19T11:00:13.376709Z","steps":["trace[745920477] 'agreement among raft nodes before linearized reading' (duration: 653.721926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.376732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.775656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-19T11:00:13.376772Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.722854Z","time spent":"653.907134ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"info","ts":"2026-04-19T11:00:13.37678Z","caller":"traceutil/trace.go:171","msg":"trace[304125284] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:356; }","duration":"603.86476ms","start":"2026-04-19T11:00:12.772903Z","end":"2026-04-19T11:00:13.376768Z","steps":["trace[304125284] 'agreement among raft nodes before linearized reading' (duration: 603.782367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.37691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.772877Z","time spent":"604.019125ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"info","ts":"2026-04-19T11:00:13.376929Z","caller":"traceutil/trace.go:171","msg":"trace[781522628] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"676.059043ms","start":"2026-04-19T11:00:12.700855Z","end":"2026-04-19T11:00:13.376914Z","steps":["trace[781522628] 'process raft request' (duration: 675.315236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.377024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.700845Z","time spent":"676.139726ms","remote":"127.0.0.1:54454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T11:00:13.377041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.591147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-19T11:00:13.37708Z","caller":"traceutil/trace.go:171","msg":"trace[1166491243] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:356; }","duration":"404.648359ms","start":"2026-04-19T11:00:12.97242Z","end":"2026-04-19T11:00:13.377068Z","steps":["trace[1166491243] 'agreement among raft nodes before linearized reading' (duration: 404.580046ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.377125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.972409Z","time spent":"404.706132ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-04-19T11:00:13.377252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.306472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-19T11:00:13.377303Z","caller":"traceutil/trace.go:171","msg":"trace[687474931] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:356; }","duration":"456.399766ms","start":"2026-04-19T11:00:12.920889Z","end":"2026-04-19T11:00:13.377289Z","steps":["trace[687474931] 'agreement among raft nodes before linearized reading' (duration: 456.318603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.377354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.92087Z","time spent":"456.471298ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-04-19T11:00:13.377426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.760157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-04-19T11:00:13.377487Z","caller":"traceutil/trace.go:171","msg":"trace[1828358736] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:356; }","duration":"504.863461ms","start":"2026-04-19T11:00:12.872608Z","end":"2026-04-19T11:00:13.377472Z","steps":["trace[1828358736] 'agreement among raft nodes before linearized reading' (duration: 504.765637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.377534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.87258Z","time spent":"504.943323ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-04-19T11:00:13.377546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.284195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-19T11:00:13.377585Z","caller":"traceutil/trace.go:171","msg":"trace[52448921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:356; }","duration":"587.320196ms","start":"2026-04-19T11:00:12.790252Z","end":"2026-04-19T11:00:13.377572Z","steps":["trace[52448921] 'agreement among raft nodes before linearized reading' (duration: 587.260104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.377486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.838558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-19T11:00:13.377631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.790139Z","time spent":"587.481672ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-19T11:00:13.377641Z","caller":"traceutil/trace.go:171","msg":"trace[1226890761] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:356; }","duration":"586.991873ms","start":"2026-04-19T11:00:12.790637Z","end":"2026-04-19T11:00:13.377628Z","steps":["trace[1226890761] 'agreement among raft nodes before linearized reading' (duration: 586.805337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.37654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.698836Z","time spent":"677.631702ms","remote":"127.0.0.1:54024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T11:00:13.377682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.790586Z","time spent":"587.084957ms","remote":"127.0.0.1:54210","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":"info","ts":"2026-04-19T11:00:13.376419Z","caller":"traceutil/trace.go:171","msg":"trace[768093104] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"679.916867ms","start":"2026-04-19T11:00:12.696485Z","end":"2026-04-19T11:00:13.376402Z","steps":["trace[768093104] 'process raft request' (duration: 679.549063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.377789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.696473Z","time spent":"681.269485ms","remote":"127.0.0.1:54408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:13.377802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.694084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-19T11:00:13.37785Z","caller":"traceutil/trace.go:171","msg":"trace[1382850462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:356; }","duration":"592.797508ms","start":"2026-04-19T11:00:12.785039Z","end":"2026-04-19T11:00:13.377837Z","steps":["trace[1382850462] 'agreement among raft nodes before linearized reading' (duration: 592.718575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.377901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.785021Z","time spent":"592.867921ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T11:00:13.378036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.454215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-04-19T11:00:13.377363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.371031ms","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-19T11:00:13.378493Z","caller":"traceutil/trace.go:171","msg":"trace[429730988] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:356; }","duration":"587.527902ms","start":"2026-04-19T11:00:12.790944Z","end":"2026-04-19T11:00:13.378472Z","steps":["trace[429730988] 'agreement among raft nodes before linearized reading' (duration: 586.344639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.378825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.790937Z","time spent":"587.771103ms","remote":"127.0.0.1:54210","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":"info","ts":"2026-04-19T11:00:13.379003Z","caller":"traceutil/trace.go:171","msg":"trace[403233616] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:356; }","duration":"555.523577ms","start":"2026-04-19T11:00:12.822543Z","end":"2026-04-19T11:00:13.378066Z","steps":["trace[403233616] 'agreement among raft nodes before linearized reading' (duration: 555.455315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.379079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:12.822524Z","time spent":"556.534055ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"info","ts":"2026-04-19T11:00:13.960119Z","caller":"traceutil/trace.go:171","msg":"trace[226417976] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"487.109066ms","start":"2026-04-19T11:00:13.472967Z","end":"2026-04-19T11:00:13.960077Z","steps":["trace[226417976] 'process raft request' (duration: 446.341598ms)","trace[226417976] 'compare' (duration: 40.54466ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:13.960328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.472941Z","time spent":"487.290843ms","remote":"127.0.0.1:54050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1739,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:13.96914Z","caller":"traceutil/trace.go:171","msg":"trace[915838470] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"424.496946ms","start":"2026-04-19T11:00:13.544631Z","end":"2026-04-19T11:00:13.969128Z","steps":["trace[915838470] 'process raft request' (duration: 424.425693ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:13.969189Z","caller":"traceutil/trace.go:171","msg":"trace[1013671984] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"491.717105ms","start":"2026-04-19T11:00:13.477443Z","end":"2026-04-19T11:00:13.96916Z","steps":["trace[1013671984] 'process raft request' (duration: 491.56918ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:13.969253Z","caller":"traceutil/trace.go:171","msg":"trace[1936687547] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"491.904272ms","start":"2026-04-19T11:00:13.477331Z","end":"2026-04-19T11:00:13.969235Z","steps":["trace[1936687547] 'process raft request' (duration: 491.634322ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:13.96924Z","caller":"traceutil/trace.go:171","msg":"trace[1183563789] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"496.129207ms","start":"2026-04-19T11:00:13.473048Z","end":"2026-04-19T11:00:13.969177Z","steps":["trace[1183563789] 'process raft request' (duration: 495.720232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.969413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.473007Z","time spent":"496.377486ms","remote":"127.0.0.1:54128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":172,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T11:00:13.969332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.477325Z","time spent":"491.976334ms","remote":"127.0.0.1:54024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:13.969577Z","caller":"traceutil/trace.go:171","msg":"trace[630404655] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"424.897911ms","start":"2026-04-19T11:00:13.544668Z","end":"2026-04-19T11:00:13.969566Z","steps":["trace[630404655] 'process raft request' (duration: 424.433084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.969694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.544639Z","time spent":"425.027386ms","remote":"127.0.0.1:54286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:13.969424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.544607Z","time spent":"424.5921ms","remote":"127.0.0.1:54408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:13.96934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.477438Z","time spent":"491.823769ms","remote":"127.0.0.1:54114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3424,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:00:13.969124Z","caller":"traceutil/trace.go:171","msg":"trace[575951499] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"491.85662ms","start":"2026-04-19T11:00:13.477237Z","end":"2026-04-19T11:00:13.969093Z","steps":["trace[575951499] 'process raft request' (duration: 491.662533ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.970019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.477226Z","time spent":"492.771745ms","remote":"127.0.0.1:54286","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:00:13.970171Z","caller":"traceutil/trace.go:171","msg":"trace[343788881] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"425.38676ms","start":"2026-04-19T11:00:13.544772Z","end":"2026-04-19T11:00:13.970159Z","steps":["trace[343788881] 'process raft request' (duration: 424.88708ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:13.970155Z","caller":"traceutil/trace.go:171","msg":"trace[337275801] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"422.357839ms","start":"2026-04-19T11:00:13.547734Z","end":"2026-04-19T11:00:13.970092Z","steps":["trace[337275801] 'process raft request' (duration: 422.251005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:13.970415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.544639Z","time spent":"425.569976ms","remote":"127.0.0.1:54434","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2886,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:13.970418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:13.547713Z","time spent":"422.552845ms","remote":"127.0.0.1:54114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:32.200226Z","caller":"traceutil/trace.go:171","msg":"trace[1078991823] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"103.829668ms","start":"2026-04-19T11:00:32.096371Z","end":"2026-04-19T11:00:32.200201Z","steps":["trace[1078991823] 'process raft request' (duration: 103.685654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.152589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381332542020148320,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-19T11:00:36.241607Z","caller":"traceutil/trace.go:171","msg":"trace[230770056] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"876.644403ms","start":"2026-04-19T11:00:35.36493Z","end":"2026-04-19T11:00:36.241574Z","steps":["trace[230770056] 'process raft request' (duration: 876.275322ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.241807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.364888Z","time spent":"876.804167ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:36.390684Z","caller":"traceutil/trace.go:171","msg":"trace[1260152118] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"1.02502483s","start":"2026-04-19T11:00:35.365593Z","end":"2026-04-19T11:00:36.390618Z","steps":["trace[1260152118] 'process raft request' (duration: 1.024639688s)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.390769Z","caller":"traceutil/trace.go:171","msg":"trace[530026532] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"1.015657492s","start":"2026-04-19T11:00:35.375034Z","end":"2026-04-19T11:00:36.390691Z","steps":["trace[530026532] 'process raft request' (duration: 1.015450876s)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.390803Z","caller":"traceutil/trace.go:171","msg":"trace[1039002343] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"1.015616961s","start":"2026-04-19T11:00:35.375155Z","end":"2026-04-19T11:00:36.390771Z","steps":["trace[1039002343] 'process raft request' (duration: 1.015376804s)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.390836Z","caller":"traceutil/trace.go:171","msg":"trace[1934717974] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"1.009876864s","start":"2026-04-19T11:00:35.380914Z","end":"2026-04-19T11:00:36.390791Z","steps":["trace[1934717974] 'process raft request' (duration: 1.00973374s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.390954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.375011Z","time spent":"1.015861049s","remote":"127.0.0.1:53992","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-19T11:00:36.390959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.380898Z","time spent":"1.009985317s","remote":"127.0.0.1:53992","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-19T11:00:36.391023Z","caller":"traceutil/trace.go:171","msg":"trace[863888984] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"992.328205ms","start":"2026-04-19T11:00:35.398675Z","end":"2026-04-19T11:00:36.391004Z","steps":["trace[863888984] 'process raft request' (duration: 992.088628ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.391069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.398659Z","time spent":"992.387848ms","remote":"127.0.0.1:53992","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-19T11:00:36.390958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.375126Z","time spent":"1.015754525s","remote":"127.0.0.1:53992","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-19T11:00:36.39114Z","caller":"traceutil/trace.go:171","msg":"trace[1959104267] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"992.246693ms","start":"2026-04-19T11:00:35.398883Z","end":"2026-04-19T11:00:36.391129Z","steps":["trace[1959104267] 'process raft request' (duration: 991.934454ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.391181Z","caller":"traceutil/trace.go:171","msg":"trace[1886125331] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"984.66219ms","start":"2026-04-19T11:00:35.406506Z","end":"2026-04-19T11:00:36.391169Z","steps":["trace[1886125331] 'process raft request' (duration: 984.359221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.391195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.398877Z","time spent":"992.296895ms","remote":"127.0.0.1:53992","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-19T11:00:36.391247Z","caller":"traceutil/trace.go:171","msg":"trace[1381438770] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"1.010271905s","start":"2026-04-19T11:00:35.380966Z","end":"2026-04-19T11:00:36.391237Z","steps":["trace[1381438770] 'process raft request' (duration: 1.0097624s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.391265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.406499Z","time spent":"984.738063ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T11:00:36.391289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.380962Z","time spent":"1.010307906s","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:36.391358Z","caller":"traceutil/trace.go:171","msg":"trace[200233277] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"947.411779ms","start":"2026-04-19T11:00:35.443936Z","end":"2026-04-19T11:00:36.391348Z","steps":["trace[200233277] 'process raft request' (duration: 947.029117ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.391373Z","caller":"traceutil/trace.go:171","msg":"trace[651741093] linearizableReadLoop","detail":"{readStateIndex:553; appliedIndex:541; }","duration":"739.732559ms","start":"2026-04-19T11:00:35.651617Z","end":"2026-04-19T11:00:36.39135Z","steps":["trace[651741093] 'read index received' (duration: 589.661151ms)","trace[651741093] 'applied index is now lower than readState.Index' (duration: 150.070568ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:36.391407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.443899Z","time spent":"947.487941ms","remote":"127.0.0.1:53992","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-19T11:00:36.391416Z","caller":"traceutil/trace.go:171","msg":"trace[2046062591] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"830.317847ms","start":"2026-04-19T11:00:35.561089Z","end":"2026-04-19T11:00:36.391406Z","steps":["trace[2046062591] 'process raft request' (duration: 830.09563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.391457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.561053Z","time spent":"830.385369ms","remote":"127.0.0.1:53992","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-19T11:00:36.391428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.365564Z","time spent":"1.025744301s","remote":"127.0.0.1:53992","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-19T11:00:36.390728Z","caller":"traceutil/trace.go:171","msg":"trace[127776974] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"1.020149479s","start":"2026-04-19T11:00:35.370507Z","end":"2026-04-19T11:00:36.390657Z","steps":["trace[127776974] 'process raft request' (duration: 1.019925532s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.391625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.997647ms","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-19T11:00:36.391684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.370496Z","time spent":"1.021061537s","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:36.39175Z","caller":"traceutil/trace.go:171","msg":"trace[1488937672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:532; }","duration":"740.119711ms","start":"2026-04-19T11:00:35.651542Z","end":"2026-04-19T11:00:36.391662Z","steps":["trace[1488937672] 'agreement among raft nodes before linearized reading' (duration: 739.913845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.391793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.651519Z","time spent":"740.263455ms","remote":"127.0.0.1:54210","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":"info","ts":"2026-04-19T11:00:36.59797Z","caller":"traceutil/trace.go:171","msg":"trace[1919931675] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"345.901191ms","start":"2026-04-19T11:00:36.252021Z","end":"2026-04-19T11:00:36.597922Z","steps":["trace[1919931675] 'process raft request' (duration: 345.786847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.598041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.8192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-19T11:00:36.598042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"940.536071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-19T11:00:36.59812Z","caller":"traceutil/trace.go:171","msg":"trace[898790785] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:534; }","duration":"940.628523ms","start":"2026-04-19T11:00:35.657476Z","end":"2026-04-19T11:00:36.598104Z","steps":["trace[898790785] 'agreement among raft nodes before linearized reading' (duration: 940.443528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.598168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.657439Z","time spent":"940.719947ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-19T11:00:36.598196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.647656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:36.598305Z","caller":"traceutil/trace.go:171","msg":"trace[2068139772] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"196.741099ms","start":"2026-04-19T11:00:36.401516Z","end":"2026-04-19T11:00:36.598257Z","steps":["trace[2068139772] 'process raft request' (duration: 196.488441ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.59838Z","caller":"traceutil/trace.go:171","msg":"trace[1324678646] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:535; }","duration":"838.869233ms","start":"2026-04-19T11:00:35.759476Z","end":"2026-04-19T11:00:36.598345Z","steps":["trace[1324678646] 'agreement among raft nodes before linearized reading' (duration: 838.577154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.598452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.759452Z","time spent":"838.985975ms","remote":"127.0.0.1:53940","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-19T11:00:36.598461Z","caller":"traceutil/trace.go:171","msg":"trace[114471730] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"350.156239ms","start":"2026-04-19T11:00:36.248251Z","end":"2026-04-19T11:00:36.598407Z","steps":["trace[114471730] 'process raft request' (duration: 342.717433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.598636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:36.248224Z","time spent":"350.326735ms","remote":"127.0.0.1:54498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:36.598719Z","caller":"traceutil/trace.go:171","msg":"trace[680886778] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"143.843699ms","start":"2026-04-19T11:00:36.454865Z","end":"2026-04-19T11:00:36.598709Z","steps":["trace[680886778] 'process raft request' (duration: 143.793297ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.597893Z","caller":"traceutil/trace.go:171","msg":"trace[176981303] linearizableReadLoop","detail":"{readStateIndex:555; appliedIndex:553; }","duration":"206.435685ms","start":"2026-04-19T11:00:36.391432Z","end":"2026-04-19T11:00:36.597867Z","steps":["trace[176981303] 'read index received' (duration: 199.597156ms)","trace[176981303] 'applied index is now lower than readState.Index' (duration: 6.837469ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:36.598846Z","caller":"traceutil/trace.go:171","msg":"trace[127548786] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"189.811687ms","start":"2026-04-19T11:00:36.409018Z","end":"2026-04-19T11:00:36.59883Z","steps":["trace[127548786] 'process raft request' (duration: 189.256301ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.598891Z","caller":"traceutil/trace.go:171","msg":"trace[687338839] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"189.720635ms","start":"2026-04-19T11:00:36.409132Z","end":"2026-04-19T11:00:36.598852Z","steps":["trace[687338839] 'process raft request' (duration: 189.21902ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.59812Z","caller":"traceutil/trace.go:171","msg":"trace[1691948513] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:534; }","duration":"941.897842ms","start":"2026-04-19T11:00:35.656198Z","end":"2026-04-19T11:00:36.598095Z","steps":["trace[1691948513] 'agreement among raft nodes before linearized reading' (duration: 941.733157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.598969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.656157Z","time spent":"942.7973ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-19T11:00:36.598925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:36.251993Z","time spent":"346.606622ms","remote":"127.0.0.1:53992","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:00:36.599031Z","caller":"traceutil/trace.go:171","msg":"trace[1264506934] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"192.924593ms","start":"2026-04-19T11:00:36.406094Z","end":"2026-04-19T11:00:36.599019Z","steps":["trace[1264506934] 'process raft request' (duration: 192.069137ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.599089Z","caller":"traceutil/trace.go:171","msg":"trace[2006024896] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"182.945329ms","start":"2026-04-19T11:00:36.416139Z","end":"2026-04-19T11:00:36.599084Z","steps":["trace[2006024896] 'process raft request' (duration: 182.375152ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.599178Z","caller":"traceutil/trace.go:171","msg":"trace[1251849190] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"181.142753ms","start":"2026-04-19T11:00:36.418029Z","end":"2026-04-19T11:00:36.599172Z","steps":["trace[1251849190] 'process raft request' (duration: 180.596897ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.599217Z","caller":"traceutil/trace.go:171","msg":"trace[108669031] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"191.468759ms","start":"2026-04-19T11:00:36.407739Z","end":"2026-04-19T11:00:36.599208Z","steps":["trace[108669031] 'process raft request' (duration: 190.469749ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.599306Z","caller":"traceutil/trace.go:171","msg":"trace[1483147531] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"191.505279ms","start":"2026-04-19T11:00:36.407792Z","end":"2026-04-19T11:00:36.599297Z","steps":["trace[1483147531] 'process raft request' (duration: 190.435917ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.59903Z","caller":"traceutil/trace.go:171","msg":"trace[1145257531] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"188.433486ms","start":"2026-04-19T11:00:36.41059Z","end":"2026-04-19T11:00:36.599023Z","steps":["trace[1145257531] 'process raft request' (duration: 187.816817ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.599399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"943.656086ms","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-19T11:00:36.599417Z","caller":"traceutil/trace.go:171","msg":"trace[1343940209] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"190.794959ms","start":"2026-04-19T11:00:36.408615Z","end":"2026-04-19T11:00:36.59941Z","steps":["trace[1343940209] 'process raft request' (duration: 189.631644ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:36.599524Z","caller":"traceutil/trace.go:171","msg":"trace[2136298848] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:545; }","duration":"943.810401ms","start":"2026-04-19T11:00:35.655629Z","end":"2026-04-19T11:00:36.59944Z","steps":["trace[2136298848] 'agreement among raft nodes before linearized reading' (duration: 943.286775ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:36.599662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:35.655617Z","time spent":"944.010577ms","remote":"127.0.0.1:54210","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-19T11:00:37.5593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.721314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:00:37.55954Z","caller":"traceutil/trace.go:171","msg":"trace[674380407] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"258.551202ms","start":"2026-04-19T11:00:37.30095Z","end":"2026-04-19T11:00:37.559501Z","steps":["trace[674380407] 'process raft request' (duration: 157.575061ms)","trace[674380407] 'compare' (duration: 100.558839ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:37.559816Z","caller":"traceutil/trace.go:171","msg":"trace[1341159804] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"131.416351ms","start":"2026-04-19T11:00:37.428386Z","end":"2026-04-19T11:00:37.559803Z","steps":["trace[1341159804] 'process raft request' (duration: 131.145843ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:37.559929Z","caller":"traceutil/trace.go:171","msg":"trace[1359614256] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"188.757313ms","start":"2026-04-19T11:00:37.371151Z","end":"2026-04-19T11:00:37.559909Z","steps":["trace[1359614256] 'process raft request' (duration: 188.250858ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:40.437422Z","caller":"traceutil/trace.go:171","msg":"trace[1798309418] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"109.236619ms","start":"2026-04-19T11:00:40.328156Z","end":"2026-04-19T11:00:40.437393Z","steps":["trace[1798309418] 'process raft request' (duration: 108.669072ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:40.598004Z","caller":"traceutil/trace.go:171","msg":"trace[414300441] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"103.242782ms","start":"2026-04-19T11:00:40.49473Z","end":"2026-04-19T11:00:40.597972Z","steps":["trace[414300441] 'process raft request' (duration: 65.869037ms)","trace[414300441] 'compare' (duration: 37.19412ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:42.258306Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381332542020148481,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-19T11:00:42.621671Z","caller":"traceutil/trace.go:171","msg":"trace[578954769] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"1.038988648s","start":"2026-04-19T11:00:41.582652Z","end":"2026-04-19T11:00:42.62164Z","steps":["trace[578954769] 'process raft request' (duration: 959.878843ms)","trace[578954769] 'compare' (duration: 78.343943ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:42.621941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:41.58261Z","time spent":"1.039133622s","remote":"127.0.0.1:54274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1044,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:42.641072Z","caller":"traceutil/trace.go:171","msg":"trace[1863681696] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:645; }","duration":"883.404507ms","start":"2026-04-19T11:00:41.757649Z","end":"2026-04-19T11:00:42.641054Z","steps":["trace[1863681696] 'read index received' (duration: 784.892036ms)","trace[1863681696] 'applied index is now lower than readState.Index' (duration: 98.511821ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:42.641091Z","caller":"traceutil/trace.go:171","msg":"trace[1314083171] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"370.23223ms","start":"2026-04-19T11:00:42.270833Z","end":"2026-04-19T11:00:42.641065Z","steps":["trace[1314083171] 'process raft request' (duration: 370.143767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.641169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"883.50578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.641195Z","caller":"traceutil/trace.go:171","msg":"trace[1883423711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"883.571571ms","start":"2026-04-19T11:00:41.757616Z","end":"2026-04-19T11:00:42.641187Z","steps":["trace[1883423711] 'agreement among raft nodes before linearized reading' (duration: 883.503879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.641215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:41.757591Z","time spent":"883.619643ms","remote":"127.0.0.1:53932","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-19T11:00:42.641249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.27081Z","time spent":"370.374054ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:42.641344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.386167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.641404Z","caller":"traceutil/trace.go:171","msg":"trace[2100258842] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:620; }","duration":"507.48598ms","start":"2026-04-19T11:00:42.133903Z","end":"2026-04-19T11:00:42.641389Z","steps":["trace[2100258842] 'agreement among raft nodes before linearized reading' (duration: 507.378947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.641437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.133886Z","time spent":"507.543902ms","remote":"127.0.0.1:35700","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-19T11:00:42.641449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.343228ms","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-19T11:00:42.641477Z","caller":"traceutil/trace.go:171","msg":"trace[149336355] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:620; }","duration":"330.43154ms","start":"2026-04-19T11:00:42.311037Z","end":"2026-04-19T11:00:42.641469Z","steps":["trace[149336355] 'agreement among raft nodes before linearized reading' (duration: 330.354738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.641554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.311027Z","time spent":"330.519393ms","remote":"127.0.0.1:35748","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":"warn","ts":"2026-04-19T11:00:42.641581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.607696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.641607Z","caller":"traceutil/trace.go:171","msg":"trace[865062372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:620; }","duration":"330.662337ms","start":"2026-04-19T11:00:42.310938Z","end":"2026-04-19T11:00:42.6416Z","steps":["trace[865062372] 'agreement among raft nodes before linearized reading' (duration: 330.623326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.641631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.310922Z","time spent":"330.703678ms","remote":"127.0.0.1:35748","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-19T11:00:42.64169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.74241ms","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-19T11:00:42.64171Z","caller":"traceutil/trace.go:171","msg":"trace[699176706] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:620; }","duration":"330.800861ms","start":"2026-04-19T11:00:42.310905Z","end":"2026-04-19T11:00:42.641705Z","steps":["trace[699176706] 'agreement among raft nodes before linearized reading' (duration: 330.76994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.641729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.310886Z","time spent":"330.838612ms","remote":"127.0.0.1:35748","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-19T11:00:42.641786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.456897ms","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-19T11:00:42.641805Z","caller":"traceutil/trace.go:171","msg":"trace[33723110] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:620; }","duration":"358.494548ms","start":"2026-04-19T11:00:42.283306Z","end":"2026-04-19T11:00:42.6418Z","steps":["trace[33723110] 'agreement among raft nodes before linearized reading' (duration: 358.465397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.641823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.283296Z","time spent":"358.52219ms","remote":"127.0.0.1:35744","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-19T11:00:42.641919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.933501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.641942Z","caller":"traceutil/trace.go:171","msg":"trace[1857865528] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:620; }","duration":"358.978452ms","start":"2026-04-19T11:00:42.282958Z","end":"2026-04-19T11:00:42.641936Z","steps":["trace[1857865528] 'agreement among raft nodes before linearized reading' (duration: 358.943181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.64196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.282944Z","time spent":"359.010683ms","remote":"127.0.0.1:35744","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-19T11:00:42.642037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.906466ms","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-19T11:00:42.642059Z","caller":"traceutil/trace.go:171","msg":"trace[1935264711] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:620; }","duration":"386.943607ms","start":"2026-04-19T11:00:42.25511Z","end":"2026-04-19T11:00:42.642054Z","steps":["trace[1935264711] 'agreement among raft nodes before linearized reading' (duration: 386.911896ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.255101Z","time spent":"386.970768ms","remote":"127.0.0.1:35728","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-19T11:00:42.642169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.582217ms","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-19T11:00:42.642191Z","caller":"traceutil/trace.go:171","msg":"trace[1045212356] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:620; }","duration":"387.644338ms","start":"2026-04-19T11:00:42.254542Z","end":"2026-04-19T11:00:42.642186Z","steps":["trace[1045212356] 'agreement among raft nodes before linearized reading' (duration: 387.611617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.254521Z","time spent":"387.68267ms","remote":"127.0.0.1:35728","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-19T11:00:42.642262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.483248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:42.642326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.976225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.642338Z","caller":"traceutil/trace.go:171","msg":"trace[679618648] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:620; }","duration":"136.589311ms","start":"2026-04-19T11:00:42.50574Z","end":"2026-04-19T11:00:42.642329Z","steps":["trace[679618648] 'agreement among raft nodes before linearized reading' (duration: 136.476868ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:42.642345Z","caller":"traceutil/trace.go:171","msg":"trace[1203595810] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"414.005687ms","start":"2026-04-19T11:00:42.228334Z","end":"2026-04-19T11:00:42.642339Z","steps":["trace[1203595810] 'agreement among raft nodes before linearized reading' (duration: 413.979986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.228327Z","time spent":"414.033967ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-19T11:00:42.642438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.911371ms","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":"warn","ts":"2026-04-19T11:00:42.642468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.011679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.642475Z","caller":"traceutil/trace.go:171","msg":"trace[1928978159] 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:620; }","duration":"486.986253ms","start":"2026-04-19T11:00:42.15548Z","end":"2026-04-19T11:00:42.642466Z","steps":["trace[1928978159] 'agreement among raft nodes before linearized reading' (duration: 486.932912ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:42.642489Z","caller":"traceutil/trace.go:171","msg":"trace[1744332932] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:620; }","duration":"505.046321ms","start":"2026-04-19T11:00:42.137438Z","end":"2026-04-19T11:00:42.642484Z","steps":["trace[1744332932] 'agreement among raft nodes before linearized reading' (duration: 505.01589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.155461Z","time spent":"487.031115ms","remote":"127.0.0.1:35706","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-19T11:00:42.642514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.137431Z","time spent":"505.077111ms","remote":"127.0.0.1:35700","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-19T11:00:42.642585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.601893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:42.642604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.81733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.642625Z","caller":"traceutil/trace.go:171","msg":"trace[1027744328] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"414.855611ms","start":"2026-04-19T11:00:42.227764Z","end":"2026-04-19T11:00:42.642619Z","steps":["trace[1027744328] 'agreement among raft nodes before linearized reading' (duration: 414.8216ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.227759Z","time spent":"414.886591ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-19T11:00:42.64271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.962794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.642733Z","caller":"traceutil/trace.go:171","msg":"trace[314650721] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:620; }","duration":"415.028366ms","start":"2026-04-19T11:00:42.227699Z","end":"2026-04-19T11:00:42.642727Z","steps":["trace[314650721] 'agreement among raft nodes before linearized reading' (duration: 414.997685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.22767Z","time spent":"415.076107ms","remote":"127.0.0.1:35726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-19T11:00:42.642745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.039754ms","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":"info","ts":"2026-04-19T11:00:42.64283Z","caller":"traceutil/trace.go:171","msg":"trace[340802243] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:620; }","duration":"137.124436ms","start":"2026-04-19T11:00:42.505698Z","end":"2026-04-19T11:00:42.642822Z","steps":["trace[340802243] 'agreement among raft nodes before linearized reading' (duration: 137.028144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.007811ms","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-19T11:00:42.642866Z","caller":"traceutil/trace.go:171","msg":"trace[1783531115] 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:620; }","duration":"456.029122ms","start":"2026-04-19T11:00:42.186831Z","end":"2026-04-19T11:00:42.64286Z","steps":["trace[1783531115] 'agreement among raft nodes before linearized reading' (duration: 455.997031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.186812Z","time spent":"456.077022ms","remote":"127.0.0.1:35716","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-19T11:00:42.64299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.305198ms","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-19T11:00:42.643013Z","caller":"traceutil/trace.go:171","msg":"trace[1913633829] 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:620; }","duration":"458.339729ms","start":"2026-04-19T11:00:42.184667Z","end":"2026-04-19T11:00:42.643007Z","steps":["trace[1913633829] 'agreement among raft nodes before linearized reading' (duration: 458.305238ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.643014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.283042ms","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-19T11:00:42.643033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.184663Z","time spent":"458.364429ms","remote":"127.0.0.1:35716","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-19T11:00:42.643062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.948982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.642606Z","caller":"traceutil/trace.go:171","msg":"trace[719968799] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:620; }","duration":"508.655675ms","start":"2026-04-19T11:00:42.133945Z","end":"2026-04-19T11:00:42.642601Z","steps":["trace[719968799] 'agreement among raft nodes before linearized reading' (duration: 508.626434ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:42.643088Z","caller":"traceutil/trace.go:171","msg":"trace[289353963] 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:620; }","duration":"486.994324ms","start":"2026-04-19T11:00:42.156087Z","end":"2026-04-19T11:00:42.643081Z","steps":["trace[289353963] 'agreement among raft nodes before linearized reading' (duration: 486.959573ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.643104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.133926Z","time spent":"509.172589ms","remote":"127.0.0.1:35700","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/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-19T11:00:42.643132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.57118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.64314Z","caller":"traceutil/trace.go:171","msg":"trace[110444059] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:620; }","duration":"312.356034ms","start":"2026-04-19T11:00:42.330676Z","end":"2026-04-19T11:00:42.643032Z","steps":["trace[110444059] 'agreement among raft nodes before linearized reading' (duration: 312.313173ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:42.643148Z","caller":"traceutil/trace.go:171","msg":"trace[135511597] 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:620; }","duration":"487.607682ms","start":"2026-04-19T11:00:42.155536Z","end":"2026-04-19T11:00:42.643144Z","steps":["trace[135511597] 'agreement among raft nodes before linearized reading' (duration: 487.583911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.642618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.875549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.643194Z","caller":"traceutil/trace.go:171","msg":"trace[1990367218] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:620; }","duration":"137.466146ms","start":"2026-04-19T11:00:42.505721Z","end":"2026-04-19T11:00:42.643187Z","steps":["trace[1990367218] 'agreement among raft nodes before linearized reading' (duration: 136.872699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.643108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.156078Z","time spent":"487.025175ms","remote":"127.0.0.1:35706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-19T11:00:42.643031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.375999ms","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-19T11:00:42.643288Z","caller":"traceutil/trace.go:171","msg":"trace[2118096793] 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:620; }","duration":"458.660818ms","start":"2026-04-19T11:00:42.184621Z","end":"2026-04-19T11:00:42.643282Z","steps":["trace[2118096793] 'agreement among raft nodes before linearized reading' (duration: 458.38818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.64331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.184608Z","time spent":"458.695869ms","remote":"127.0.0.1:35716","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-19T11:00:42.643169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.155531Z","time spent":"487.633962ms","remote":"127.0.0.1:35706","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":"warn","ts":"2026-04-19T11:00:42.643297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.74938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.643408Z","caller":"traceutil/trace.go:171","msg":"trace[783423796] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:620; }","duration":"318.877814ms","start":"2026-04-19T11:00:42.324522Z","end":"2026-04-19T11:00:42.6434Z","steps":["trace[783423796] 'agreement among raft nodes before linearized reading' (duration: 318.755481ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.643433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.324514Z","time spent":"318.910025ms","remote":"127.0.0.1:35762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-19T11:00:42.643553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.039508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:42.643583Z","caller":"traceutil/trace.go:171","msg":"trace[1972854555] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:620; }","duration":"319.083419ms","start":"2026-04-19T11:00:42.324493Z","end":"2026-04-19T11:00:42.643576Z","steps":["trace[1972854555] 'agreement among raft nodes before linearized reading' (duration: 319.042318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.643602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.324485Z","time spent":"319.111931ms","remote":"127.0.0.1:35762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-19T11:00:42.642301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.70461ms","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":"info","ts":"2026-04-19T11:00:42.643626Z","caller":"traceutil/trace.go:171","msg":"trace[171472772] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:620; }","duration":"389.050898ms","start":"2026-04-19T11:00:42.25457Z","end":"2026-04-19T11:00:42.643621Z","steps":["trace[171472772] 'agreement among raft nodes before linearized reading' (duration: 387.693899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:42.643646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.254545Z","time spent":"389.09356ms","remote":"127.0.0.1:35728","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":"warn","ts":"2026-04-19T11:00:42.64323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.330654Z","time spent":"312.509948ms","remote":"127.0.0.1:35762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-19T11:00:43.289697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.176392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-19T11:00:43.28995Z","caller":"traceutil/trace.go:171","msg":"trace[1628405043] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:650; }","duration":"580.733598ms","start":"2026-04-19T11:00:42.709169Z","end":"2026-04-19T11:00:43.289903Z","steps":["trace[1628405043] 'read index received' (duration: 189.01477ms)","trace[1628405043] 'applied index is now lower than readState.Index' (duration: 391.718198ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:43.290034Z","caller":"traceutil/trace.go:171","msg":"trace[627688586] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"588.677658ms","start":"2026-04-19T11:00:42.701319Z","end":"2026-04-19T11:00:43.289997Z","steps":["trace[627688586] 'process raft request' (duration: 196.799346ms)","trace[627688586] 'compare' (duration: 391.000176ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:43.290255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.061957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:43.29036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.70129Z","time spent":"588.765431ms","remote":"127.0.0.1:54210","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-19T11:00:43.290379Z","caller":"traceutil/trace.go:171","msg":"trace[1647177927] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"581.223932ms","start":"2026-04-19T11:00:42.709133Z","end":"2026-04-19T11:00:43.290356Z","steps":["trace[1647177927] 'agreement among raft nodes before linearized reading' (duration: 581.028156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.290428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.709119Z","time spent":"581.297553ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"info","ts":"2026-04-19T11:00:43.290575Z","caller":"traceutil/trace.go:171","msg":"trace[535349561] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"588.977166ms","start":"2026-04-19T11:00:42.701571Z","end":"2026-04-19T11:00:43.290548Z","steps":["trace[535349561] 'process raft request' (duration: 588.286376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.290836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.701556Z","time spent":"589.230064ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:43.303511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.686284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:43.303567Z","caller":"traceutil/trace.go:171","msg":"trace[633465396] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:625; }","duration":"138.763076ms","start":"2026-04-19T11:00:43.164792Z","end":"2026-04-19T11:00:43.303555Z","steps":["trace[633465396] 'agreement among raft nodes before linearized reading' (duration: 138.665813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.303567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.227169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:43.303615Z","caller":"traceutil/trace.go:171","msg":"trace[1129196169] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:625; }","duration":"139.280971ms","start":"2026-04-19T11:00:43.16432Z","end":"2026-04-19T11:00:43.303601Z","steps":["trace[1129196169] 'agreement among raft nodes before linearized reading' (duration: 139.223729ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.304402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.532807ms","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-19T11:00:43.304477Z","caller":"traceutil/trace.go:171","msg":"trace[990175833] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"292.359071ms","start":"2026-04-19T11:00:43.012106Z","end":"2026-04-19T11:00:43.304465Z","steps":["trace[990175833] 'agreement among raft nodes before linearized reading' (duration: 291.518847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.303679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.300106ms","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-19T11:00:43.306335Z","caller":"traceutil/trace.go:171","msg":"trace[1348568902] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"577.979054ms","start":"2026-04-19T11:00:42.728346Z","end":"2026-04-19T11:00:43.306325Z","steps":["trace[1348568902] 'agreement among raft nodes before linearized reading' (duration: 575.296866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.306418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.72833Z","time spent":"578.073066ms","remote":"127.0.0.1:35836","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-19T11:00:43.303702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.708188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:00:43.306648Z","caller":"traceutil/trace.go:171","msg":"trace[1820704510] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"578.678544ms","start":"2026-04-19T11:00:42.727952Z","end":"2026-04-19T11:00:43.306631Z","steps":["trace[1820704510] 'agreement among raft nodes before linearized reading' (duration: 575.719538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.306891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.727938Z","time spent":"578.92438ms","remote":"127.0.0.1:35836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-19T11:00:43.303712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.438342ms","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-19T11:00:43.303724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.882097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:43.303763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.005882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:43.303744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.418909ms","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-19T11:00:43.303787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.545215ms","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-19T11:00:43.303797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.463137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:43.303824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.425397ms","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":"warn","ts":"2026-04-19T11:00:43.303834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.384023ms","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-19T11:00:43.303833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.596888ms","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":"warn","ts":"2026-04-19T11:00:43.30383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.373839ms","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-19T11:00:43.303871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.593586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:43.303905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.798416ms","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":"warn","ts":"2026-04-19T11:00:43.303929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.171297ms","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":"info","ts":"2026-04-19T11:00:43.304106Z","caller":"traceutil/trace.go:171","msg":"trace[489107506] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"253.916299ms","start":"2026-04-19T11:00:43.050173Z","end":"2026-04-19T11:00:43.30409Z","steps":["trace[489107506] 'process raft request' (duration: 252.520418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.303504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.148075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-19T11:00:43.304364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.271859ms","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-19T11:00:43.307313Z","caller":"traceutil/trace.go:171","msg":"trace[767906160] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"459.010736ms","start":"2026-04-19T11:00:42.848254Z","end":"2026-04-19T11:00:43.307265Z","steps":["trace[767906160] 'agreement among raft nodes before linearized reading' (duration: 455.441253ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307722Z","caller":"traceutil/trace.go:171","msg":"trace[485711050] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"292.309809ms","start":"2026-04-19T11:00:43.015372Z","end":"2026-04-19T11:00:43.307682Z","steps":["trace[485711050] 'agreement among raft nodes before linearized reading' (duration: 288.437707ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307759Z","caller":"traceutil/trace.go:171","msg":"trace[1456982227] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"579.454056ms","start":"2026-04-19T11:00:42.728295Z","end":"2026-04-19T11:00:43.307749Z","steps":["trace[1456982227] 'agreement among raft nodes before linearized reading' (duration: 575.43152ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307762Z","caller":"traceutil/trace.go:171","msg":"trace[1384546505] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:625; }","duration":"597.929634ms","start":"2026-04-19T11:00:42.709819Z","end":"2026-04-19T11:00:43.307749Z","steps":["trace[1384546505] 'agreement among raft nodes before linearized reading' (duration: 593.881947ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307781Z","caller":"traceutil/trace.go:171","msg":"trace[16917802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"550.049339ms","start":"2026-04-19T11:00:42.757726Z","end":"2026-04-19T11:00:43.307775Z","steps":["trace[16917802] 'agreement among raft nodes before linearized reading' (duration: 546.026142ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307787Z","caller":"traceutil/trace.go:171","msg":"trace[431068210] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:625; }","duration":"143.509753ms","start":"2026-04-19T11:00:43.164269Z","end":"2026-04-19T11:00:43.307779Z","steps":["trace[431068210] 'agreement among raft nodes before linearized reading' (duration: 139.509717ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307796Z","caller":"traceutil/trace.go:171","msg":"trace[1736687278] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"195.376165ms","start":"2026-04-19T11:00:43.112416Z","end":"2026-04-19T11:00:43.307792Z","steps":["trace[1736687278] 'agreement among raft nodes before linearized reading' (duration: 191.326598ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307779Z","caller":"traceutil/trace.go:171","msg":"trace[142302466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"459.564121ms","start":"2026-04-19T11:00:42.848199Z","end":"2026-04-19T11:00:43.307763Z","steps":["trace[142302466] 'agreement among raft nodes before linearized reading' (duration: 455.528975ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307809Z","caller":"traceutil/trace.go:171","msg":"trace[930698782] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"193.614263ms","start":"2026-04-19T11:00:43.114191Z","end":"2026-04-19T11:00:43.307805Z","steps":["trace[930698782] 'agreement among raft nodes before linearized reading' (duration: 189.615728ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307807Z","caller":"traceutil/trace.go:171","msg":"trace[1862065926] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"295.368237ms","start":"2026-04-19T11:00:43.012433Z","end":"2026-04-19T11:00:43.307802Z","steps":["trace[1862065926] 'agreement among raft nodes before linearized reading' (duration: 291.385652ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307829Z","caller":"traceutil/trace.go:171","msg":"trace[642757840] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"195.600091ms","start":"2026-04-19T11:00:43.112217Z","end":"2026-04-19T11:00:43.307817Z","steps":["trace[642757840] 'agreement among raft nodes before linearized reading' (duration: 191.636856ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.307849Z","caller":"traceutil/trace.go:171","msg":"trace[884037989] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"115.734289ms","start":"2026-04-19T11:00:43.192086Z","end":"2026-04-19T11:00:43.307821Z","steps":["trace[884037989] 'agreement among raft nodes before linearized reading' (duration: 111.804365ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.308706Z","caller":"traceutil/trace.go:171","msg":"trace[2143976071] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"115.951676ms","start":"2026-04-19T11:00:43.192743Z","end":"2026-04-19T11:00:43.308694Z","steps":["trace[2143976071] 'agreement among raft nodes before linearized reading' (duration: 111.173098ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.308923Z","caller":"traceutil/trace.go:171","msg":"trace[1379985392] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:625; }","duration":"599.601044ms","start":"2026-04-19T11:00:42.709311Z","end":"2026-04-19T11:00:43.308913Z","steps":["trace[1379985392] 'agreement among raft nodes before linearized reading' (duration: 594.139076ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:00:43.308948Z","caller":"traceutil/trace.go:171","msg":"trace[641878761] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"116.870573ms","start":"2026-04-19T11:00:43.192068Z","end":"2026-04-19T11:00:43.308939Z","steps":["trace[641878761] 'agreement among raft nodes before linearized reading' (duration: 112.277159ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:43.309224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.847944Z","time spent":"461.227871ms","remote":"127.0.0.1:35840","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-19T11:00:43.309299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.728268Z","time spent":"581.017842ms","remote":"127.0.0.1:35836","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":"warn","ts":"2026-04-19T11:00:43.309335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.757708Z","time spent":"551.619454ms","remote":"127.0.0.1:53932","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-19T11:00:43.309368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.709811Z","time spent":"599.546951ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-19T11:00:43.309542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.848104Z","time spent":"461.426766ms","remote":"127.0.0.1:35840","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-19T11:00:43.313013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:42.709305Z","time spent":"603.691802ms","remote":"127.0.0.1:35822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-19T11:00:44.459808Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381332542020148510,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T11:00:44.960039Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381332542020148510,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T11:00:45.383517Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.45304432s","expected-duration":"1s"} {"level":"info","ts":"2026-04-19T11:00:45.38429Z","caller":"traceutil/trace.go:171","msg":"trace[1033218644] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"1.425164571s","start":"2026-04-19T11:00:43.959097Z","end":"2026-04-19T11:00:45.384262Z","steps":["trace[1033218644] 'read index received' (duration: 1.424520833s)","trace[1033218644] 'applied index is now lower than readState.Index' (duration: 643.248µs)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:45.384354Z","caller":"traceutil/trace.go:171","msg":"trace[554810413] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"1.55814072s","start":"2026-04-19T11:00:43.826206Z","end":"2026-04-19T11:00:45.384347Z","steps":["trace[554810413] 'process raft request' (duration: 1.557636046s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.384437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:43.826186Z","time spent":"1.558185661s","remote":"127.0.0.1:54048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036273,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:00:45.384667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425575044s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-zx7l9\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-19T11:00:45.384693Z","caller":"traceutil/trace.go:171","msg":"trace[428519048] range","detail":"{range_begin:/registry/pods/kube-system/cilium-zx7l9; range_end:; response_count:1; response_revision:630; }","duration":"1.425633346s","start":"2026-04-19T11:00:43.959053Z","end":"2026-04-19T11:00:45.384687Z","steps":["trace[428519048] 'agreement among raft nodes before linearized reading' (duration: 1.425546983s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.384712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:43.959035Z","time spent":"1.425672807s","remote":"127.0.0.1:54114","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-zx7l9\" "} {"level":"warn","ts":"2026-04-19T11:00:45.384851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.066156ms","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-19T11:00:45.384873Z","caller":"traceutil/trace.go:171","msg":"trace[2095199797] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:630; }","duration":"722.224721ms","start":"2026-04-19T11:00:44.662643Z","end":"2026-04-19T11:00:45.384868Z","steps":["trace[2095199797] 'agreement among raft nodes before linearized reading' (duration: 722.167199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.38489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:44.662619Z","time spent":"722.267883ms","remote":"127.0.0.1:54210","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-19T11:00:45.385213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.20089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-19T11:00:45.385239Z","caller":"traceutil/trace.go:171","msg":"trace[924092083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:630; }","duration":"675.256271ms","start":"2026-04-19T11:00:44.709977Z","end":"2026-04-19T11:00:45.385234Z","steps":["trace[924092083] 'agreement among raft nodes before linearized reading' (duration: 675.20275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.385256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:44.709959Z","time spent":"675.292652ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-19T11:00:45.659768Z","caller":"traceutil/trace.go:171","msg":"trace[1670852871] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"267.498875ms","start":"2026-04-19T11:00:45.392244Z","end":"2026-04-19T11:00:45.659743Z","steps":["trace[1670852871] 'process raft request' (duration: 229.416428ms)","trace[1670852871] 'compare' (duration: 37.870151ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:00:45.793123Z","caller":"traceutil/trace.go:171","msg":"trace[1181026183] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"400.336816ms","start":"2026-04-19T11:00:45.392766Z","end":"2026-04-19T11:00:45.793103Z","steps":["trace[1181026183] 'process raft request' (duration: 383.587148ms)","trace[1181026183] 'compare' (duration: 16.585993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:45.793245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:45.392755Z","time spent":"400.425859ms","remote":"127.0.0.1:54210","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-19T11:00:45.79339Z","caller":"traceutil/trace.go:171","msg":"trace[2071093622] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"400.236282ms","start":"2026-04-19T11:00:45.393123Z","end":"2026-04-19T11:00:45.793359Z","steps":["trace[2071093622] 'process raft request' (duration: 399.949174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.793589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:45.393109Z","time spent":"400.390047ms","remote":"127.0.0.1:54210","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-19T11:00:45.793606Z","caller":"traceutil/trace.go:171","msg":"trace[323763431] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"393.083329ms","start":"2026-04-19T11:00:45.400514Z","end":"2026-04-19T11:00:45.793598Z","steps":["trace[323763431] 'process raft request' (duration: 392.951595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.793881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:45.400493Z","time spent":"393.368268ms","remote":"127.0.0.1:54114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:00:45.793651Z","caller":"traceutil/trace.go:171","msg":"trace[780285641] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"399.242814ms","start":"2026-04-19T11:00:45.39438Z","end":"2026-04-19T11:00:45.793623Z","steps":["trace[780285641] 'process raft request' (duration: 398.944106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.793984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:45.394356Z","time spent":"399.613526ms","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:00:45.793953Z","caller":"traceutil/trace.go:171","msg":"trace[1473400300] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"331.965985ms","start":"2026-04-19T11:00:45.461967Z","end":"2026-04-19T11:00:45.793933Z","steps":["trace[1473400300] 'process raft request' (duration: 331.568793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:00:45.795385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:45.461952Z","time spent":"333.369765ms","remote":"127.0.0.1:54302","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-19T11:00:47.50758Z","caller":"traceutil/trace.go:171","msg":"trace[1831458867] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"404.432596ms","start":"2026-04-19T11:00:47.10313Z","end":"2026-04-19T11:00:47.507563Z","steps":["trace[1831458867] 'process raft request' (duration: 387.411747ms)","trace[1831458867] 'compare' (duration: 16.499735ms)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:00:47.507828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:00:47.103106Z","time spent":"404.622362ms","remote":"127.0.0.1:54024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-19T11:01:04.236288Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381332542020148849,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T11:01:04.737417Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11381332542020148849,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-19T11:01:05.172093Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.513635972s","expected-duration":"1s"} {"level":"info","ts":"2026-04-19T11:01:05.172887Z","caller":"traceutil/trace.go:171","msg":"trace[300895788] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"1.514510724s","start":"2026-04-19T11:01:03.658352Z","end":"2026-04-19T11:01:05.172862Z","steps":["trace[300895788] 'process raft request' (duration: 1.51433978s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.173084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:03.658334Z","time spent":"1.514625017s","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-19T11:01:05.183759Z","caller":"traceutil/trace.go:171","msg":"trace[1058560175] linearizableReadLoop","detail":"{readStateIndex:838; appliedIndex:836; }","duration":"1.448405088s","start":"2026-04-19T11:01:03.735339Z","end":"2026-04-19T11:01:05.183744Z","steps":["trace[1058560175] 'read index received' (duration: 1.437222917s)","trace[1058560175] 'applied index is now lower than readState.Index' (duration: 11.180371ms)"],"step_count":2} {"level":"info","ts":"2026-04-19T11:01:05.184059Z","caller":"traceutil/trace.go:171","msg":"trace[1696854411] transaction","detail":"{read_only:false; response_revision:805; number_of_response:1; }","duration":"1.091292078s","start":"2026-04-19T11:01:04.092707Z","end":"2026-04-19T11:01:05.183999Z","steps":["trace[1696854411] 'process raft request' (duration: 1.09097499s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.184182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.289228094s","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-19T11:01:05.184254Z","caller":"traceutil/trace.go:171","msg":"trace[147072575] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:805; }","duration":"1.289334097s","start":"2026-04-19T11:01:03.894901Z","end":"2026-04-19T11:01:05.184235Z","steps":["trace[147072575] 'agreement among raft nodes before linearized reading' (duration: 1.289169913s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.184327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:04.092678Z","time spent":"1.091504004s","remote":"127.0.0.1:54178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-19T11:01:05.184363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.288119646s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-19T11:01:05.184352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:03.894882Z","time spent":"1.289390799s","remote":"127.0.0.1:54210","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-19T11:01:05.184512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"695.625053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-19T11:01:05.184564Z","caller":"traceutil/trace.go:171","msg":"trace[1625069464] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:805; }","duration":"695.722075ms","start":"2026-04-19T11:01:04.488829Z","end":"2026-04-19T11:01:05.184551Z","steps":["trace[1625069464] 'agreement among raft nodes before linearized reading' (duration: 695.644473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.184648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:04.488807Z","time spent":"695.829528ms","remote":"127.0.0.1:54122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":2,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-04-19T11:01:05.184503Z","caller":"traceutil/trace.go:171","msg":"trace[1483791230] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:805; }","duration":"1.288280781s","start":"2026-04-19T11:01:03.896195Z","end":"2026-04-19T11:01:05.184476Z","steps":["trace[1483791230] 'agreement among raft nodes before linearized reading' (duration: 1.287763238s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.184736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:03.896177Z","time spent":"1.288549377s","remote":"127.0.0.1:54210","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-19T11:01:05.184943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.428407479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:01:05.185006Z","caller":"traceutil/trace.go:171","msg":"trace[2101908579] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:805; }","duration":"1.42847035s","start":"2026-04-19T11:01:03.756499Z","end":"2026-04-19T11:01:05.184969Z","steps":["trace[2101908579] 'agreement among raft nodes before linearized reading' (duration: 1.427389373s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.185034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:03.756485Z","time spent":"1.428542122s","remote":"127.0.0.1:53932","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-19T11:01:05.185083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286702762s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-04-19T11:01:05.185197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.449851705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-19T11:01:05.186016Z","caller":"traceutil/trace.go:171","msg":"trace[1734684885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:805; }","duration":"1.450695026s","start":"2026-04-19T11:01:03.735309Z","end":"2026-04-19T11:01:05.186004Z","steps":["trace[1734684885] 'agreement among raft nodes before linearized reading' (duration: 1.449769423s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.186055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:03.735297Z","time spent":"1.450747137s","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-19T11:01:05.185198Z","caller":"traceutil/trace.go:171","msg":"trace[520367705] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:805; }","duration":"1.286833025s","start":"2026-04-19T11:01:03.898347Z","end":"2026-04-19T11:01:05.18518Z","steps":["trace[520367705] 'agreement among raft nodes before linearized reading' (duration: 1.285594753s)"],"step_count":1} {"level":"warn","ts":"2026-04-19T11:01:05.186208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-19T11:01:03.898335Z","time spent":"1.28785953s","remote":"127.0.0.1:54210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-19T11:02:49.947441Z","caller":"traceutil/trace.go:171","msg":"trace[1853767414] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"181.23299ms","start":"2026-04-19T11:02:49.766182Z","end":"2026-04-19T11:02:49.947415Z","steps":["trace[1853767414] 'read index received' (duration: 181.018587ms)","trace[1853767414] 'applied index is now lower than readState.Index' (duration: 213.213µs)"],"step_count":2} {"level":"warn","ts":"2026-04-19T11:02:49.947605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.392665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-19T11:02:49.947669Z","caller":"traceutil/trace.go:171","msg":"trace[399512319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1311; }","duration":"181.512396ms","start":"2026-04-19T11:02:49.766138Z","end":"2026-04-19T11:02:49.94765Z","steps":["trace[399512319] 'agreement among raft nodes before linearized reading' (duration: 181.381773ms)"],"step_count":1} {"level":"info","ts":"2026-04-19T11:02:49.947512Z","caller":"traceutil/trace.go:171","msg":"trace[1643839033] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"181.677399ms","start":"2026-04-19T11:02:49.765805Z","end":"2026-04-19T11:02:49.947483Z","steps":["trace[1643839033] 'process raft request' (duration: 181.451025ms)"],"step_count":1}