{"level":"warn","ts":"2026-04-16T06:09:50.210096Z","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-16T06:09:50.210174Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-16T06:09:50.210236Z","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-16T06:09:50.21025Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-16T06:09:50.210271Z","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-16T06:09:50.211269Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-04-16T06:09:50.211374Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-16T06:09:50.21679Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.157424ms"} {"level":"info","ts":"2026-04-16T06:09:50.224027Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-04-16T06:09:50.2241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T06:09:50.224121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-04-16T06:09:50.22413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T06:09:50.224139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-04-16T06:09:50.224189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-04-16T06:09:50.234632Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T06:09:50.237753Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T06:09:50.23931Z","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-16T06:09:50.24162Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T06:09:50.244471Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T06:09:50.244537Z","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-16T06:09:50.244645Z","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-16T06:09:50.244663Z","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-16T06:09:50.253757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-04-16T06:09:50.253882Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-04-16T06:09:50.254353Z","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-16T06:09:50.25466Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-16T06:09:50.254707Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-04-16T06:09:50.254701Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T06:09:50.254765Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T06:09:50.925289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T06:09:50.925331Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T06:09:50.925344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-04-16T06:09:50.925354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-04-16T06:09:50.92536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-16T06:09:50.925368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-04-16T06:09:50.925375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-04-16T06:09:50.927467Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:09:50.929223Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T06:09:50.929233Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:09:50.929278Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:09:50.929328Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:09:50.929437Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:09:50.929469Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:09:50.929728Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T06:09:50.929751Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T06:09:50.932876Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T06:09:50.933449Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-04-16T06:10:12.74747Z","caller":"traceutil/trace.go:171","msg":"trace[398707475] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"153.710738ms","start":"2026-04-16T06:10:12.593713Z","end":"2026-04-16T06:10:12.747424Z","steps":["trace[398707475] 'process raft request' (duration: 82.67043ms)","trace[398707475] 'compare' (duration: 70.739689ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:15.897355Z","caller":"traceutil/trace.go:171","msg":"trace[1807023105] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"594.186912ms","start":"2026-04-16T06:10:15.303139Z","end":"2026-04-16T06:10:15.897326Z","steps":["trace[1807023105] 'process raft request' (duration: 593.967167ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:15.898231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:15.303124Z","time spent":"594.394457ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:10:16.122784Z","caller":"traceutil/trace.go:171","msg":"trace[1259330842] linearizableReadLoop","detail":"{readStateIndex:438; appliedIndex:436; }","duration":"450.000012ms","start":"2026-04-16T06:10:15.672747Z","end":"2026-04-16T06:10:16.122747Z","steps":["trace[1259330842] 'read index received' (duration: 224.366495ms)","trace[1259330842] 'applied index is now lower than readState.Index' (duration: 225.632507ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:16.122939Z","caller":"traceutil/trace.go:171","msg":"trace[465896414] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"603.404761ms","start":"2026-04-16T06:10:15.519493Z","end":"2026-04-16T06:10:16.122898Z","steps":["trace[465896414] 'process raft request' (duration: 597.501228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:16.123083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:15.519462Z","time spent":"603.540105ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:10:16.123077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.300651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:16.12323Z","caller":"traceutil/trace.go:171","msg":"trace[537385757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"450.508116ms","start":"2026-04-16T06:10:15.672703Z","end":"2026-04-16T06:10:16.123212Z","steps":["trace[537385757] 'agreement among raft nodes before linearized reading' (duration: 450.265039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:16.123317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:15.672684Z","time spent":"450.610879ms","remote":"127.0.0.1:41740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T06:10:21.045419Z","caller":"traceutil/trace.go:171","msg":"trace[815410804] linearizableReadLoop","detail":"{readStateIndex:484; appliedIndex:483; }","duration":"272.279451ms","start":"2026-04-16T06:10:20.77312Z","end":"2026-04-16T06:10:21.045399Z","steps":["trace[815410804] 'read index received' (duration: 272.175507ms)","trace[815410804] 'applied index is now lower than readState.Index' (duration: 103.024µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:21.045501Z","caller":"traceutil/trace.go:171","msg":"trace[376641691] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"349.834668ms","start":"2026-04-16T06:10:20.695646Z","end":"2026-04-16T06:10:21.04548Z","steps":["trace[376641691] 'process raft request' (duration: 349.645722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:21.045568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.962587ms","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-16T06:10:21.045585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.449205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:21.045648Z","caller":"traceutil/trace.go:171","msg":"trace[209841061] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:466; }","duration":"272.564447ms","start":"2026-04-16T06:10:20.773064Z","end":"2026-04-16T06:10:21.045628Z","steps":["trace[209841061] 'agreement among raft nodes before linearized reading' (duration: 272.444274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:21.045624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:20.695619Z","time spent":"349.934781ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:10:21.045593Z","caller":"traceutil/trace.go:171","msg":"trace[719463121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:466; }","duration":"266.035738ms","start":"2026-04-16T06:10:20.779551Z","end":"2026-04-16T06:10:21.045587Z","steps":["trace[719463121] 'agreement among raft nodes before linearized reading' (duration: 265.961597ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:21.396403Z","caller":"traceutil/trace.go:171","msg":"trace[1033998981] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"347.096107ms","start":"2026-04-16T06:10:21.04928Z","end":"2026-04-16T06:10:21.396377Z","steps":["trace[1033998981] 'process raft request' (duration: 344.882549ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:21.396569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:21.049267Z","time spent":"347.206869ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:10:23.00383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"744.116551ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:10:23.004082Z","caller":"traceutil/trace.go:171","msg":"trace[869996473] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"1.172814729s","start":"2026-04-16T06:10:21.831239Z","end":"2026-04-16T06:10:23.004053Z","steps":["trace[869996473] 'process raft request' (duration: 428.221826ms)","trace[869996473] 'compare' (duration: 743.984697ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:23.004102Z","caller":"traceutil/trace.go:171","msg":"trace[1982916220] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"1.150974791s","start":"2026-04-16T06:10:21.853116Z","end":"2026-04-16T06:10:23.004091Z","steps":["trace[1982916220] 'process raft request' (duration: 1.150843437s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:23.004163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:21.831088Z","time spent":"1.173032334s","remote":"127.0.0.1:41782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:10:23.004191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:21.853089Z","time spent":"1.151057783s","remote":"127.0.0.1:41782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23066,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:10:23.004349Z","caller":"traceutil/trace.go:171","msg":"trace[4895788] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"1.143549489s","start":"2026-04-16T06:10:21.86079Z","end":"2026-04-16T06:10:23.004339Z","steps":["trace[4895788] 'process raft request' (duration: 1.143262711s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:23.004391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:21.860754Z","time spent":"1.14361646s","remote":"127.0.0.1:41782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:10:23.004485Z","caller":"traceutil/trace.go:171","msg":"trace[1450005464] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"1.137903131s","start":"2026-04-16T06:10:21.866573Z","end":"2026-04-16T06:10:23.004476Z","steps":["trace[1450005464] 'process raft request' (duration: 1.137707846s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:23.004487Z","caller":"traceutil/trace.go:171","msg":"trace[1121188311] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:523; }","duration":"1.079702798s","start":"2026-04-16T06:10:21.924763Z","end":"2026-04-16T06:10:23.004466Z","steps":["trace[1121188311] 'read index received' (duration: 334.623822ms)","trace[1121188311] 'applied index is now lower than readState.Index' (duration: 745.078296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:23.004536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:21.866527Z","time spent":"1.137981574s","remote":"127.0.0.1:41782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:10:23.004613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.079835551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T06:10:23.004641Z","caller":"traceutil/trace.go:171","msg":"trace[2143992525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"1.079904892s","start":"2026-04-16T06:10:21.924729Z","end":"2026-04-16T06:10:23.004634Z","steps":["trace[2143992525] 'agreement among raft nodes before linearized reading' (duration: 1.07982851s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:23.004666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:21.92471Z","time spent":"1.079950415s","remote":"127.0.0.1:42006","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-16T06:10:23.016872Z","caller":"traceutil/trace.go:171","msg":"trace[1724742925] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"254.475527ms","start":"2026-04-16T06:10:22.76238Z","end":"2026-04-16T06:10:23.016855Z","steps":["trace[1724742925] 'process raft request' (duration: 254.386275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:23.017299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.627631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T06:10:23.017334Z","caller":"traceutil/trace.go:171","msg":"trace[1363904266] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:508; }","duration":"552.673142ms","start":"2026-04-16T06:10:22.464653Z","end":"2026-04-16T06:10:23.017326Z","steps":["trace[1363904266] 'agreement among raft nodes before linearized reading' (duration: 552.60994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:23.017362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:22.464609Z","time spent":"552.744464ms","remote":"127.0.0.1:42006","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-16T06:10:23.017454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.118339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:23.017477Z","caller":"traceutil/trace.go:171","msg":"trace[676568913] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:508; }","duration":"329.17304ms","start":"2026-04-16T06:10:22.688298Z","end":"2026-04-16T06:10:23.017471Z","steps":["trace[676568913] 'agreement among raft nodes before linearized reading' (duration: 329.140099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:23.017497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:22.688279Z","time spent":"329.213571ms","remote":"127.0.0.1:41740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T06:10:23.543755Z","caller":"traceutil/trace.go:171","msg":"trace[1430818020] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"112.899616ms","start":"2026-04-16T06:10:23.430828Z","end":"2026-04-16T06:10:23.543728Z","steps":["trace[1430818020] 'process raft request' (duration: 112.681161ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:23.543829Z","caller":"traceutil/trace.go:171","msg":"trace[2082317079] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"134.484077ms","start":"2026-04-16T06:10:23.409313Z","end":"2026-04-16T06:10:23.543797Z","steps":["trace[2082317079] 'process raft request' (duration: 130.568226ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:26.04517Z","caller":"traceutil/trace.go:171","msg":"trace[1289902938] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"347.280391ms","start":"2026-04-16T06:10:25.697858Z","end":"2026-04-16T06:10:26.045138Z","steps":["trace[1289902938] 'process raft request' (duration: 347.068106ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:26.045352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:25.697841Z","time spent":"347.430184ms","remote":"127.0.0.1:41846","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":397,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:10:28.709313Z","caller":"traceutil/trace.go:171","msg":"trace[1311786247] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"194.869547ms","start":"2026-04-16T06:10:28.51442Z","end":"2026-04-16T06:10:28.70929Z","steps":["trace[1311786247] 'process raft request' (duration: 194.728174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:29.403147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.888025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:29.403712Z","caller":"traceutil/trace.go:171","msg":"trace[1746681908] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"884.083039ms","start":"2026-04-16T06:10:28.519609Z","end":"2026-04-16T06:10:29.403692Z","steps":["trace[1746681908] 'process raft request' (duration: 875.082795ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:29.403702Z","caller":"traceutil/trace.go:171","msg":"trace[562245667] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:591; }","duration":"728.71075ms","start":"2026-04-16T06:10:28.67423Z","end":"2026-04-16T06:10:29.402941Z","steps":["trace[562245667] 'read index received' (duration: 34.972749ms)","trace[562245667] 'applied index is now lower than readState.Index' (duration: 693.736451ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:29.403756Z","caller":"traceutil/trace.go:171","msg":"trace[1264986879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"729.512961ms","start":"2026-04-16T06:10:28.674213Z","end":"2026-04-16T06:10:29.403726Z","steps":["trace[1264986879] 'agreement among raft nodes before linearized reading' (duration: 728.781722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:29.404457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:28.674145Z","time spent":"730.27587ms","remote":"127.0.0.1:41740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:10:29.404286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:28.519574Z","time spent":"884.205043ms","remote":"127.0.0.1:41834","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:10:30.697609Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.214900484s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-16T06:10:30.906489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.491524577s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-16T06:10:30.906723Z","caller":"traceutil/trace.go:171","msg":"trace[697798679] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"1.502919193s","start":"2026-04-16T06:10:29.403791Z","end":"2026-04-16T06:10:30.90671Z","steps":["trace[697798679] 'read index received' (duration: 11.107369ms)","trace[697798679] 'applied index is now lower than readState.Index' (duration: 1.491811164s)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:30.907004Z","caller":"traceutil/trace.go:171","msg":"trace[809063730] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"1.450207252s","start":"2026-04-16T06:10:29.45679Z","end":"2026-04-16T06:10:30.906998Z","steps":["trace[809063730] 'process raft request' (duration: 1.449793091s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:30.907108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:29.456765Z","time spent":"1.450257284s","remote":"127.0.0.1:42084","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1092,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T06:10:31.594332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.305124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.594412Z","caller":"traceutil/trace.go:171","msg":"trace[766621197] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:573; }","duration":"354.424917ms","start":"2026-04-16T06:10:31.23997Z","end":"2026-04-16T06:10:31.594395Z","steps":["trace[766621197] 'count revisions from in-memory index tree' (duration: 354.213341ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.594453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.239957Z","time spent":"354.484699ms","remote":"127.0.0.1:37830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:10:31.594452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.413076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.59452Z","caller":"traceutil/trace.go:171","msg":"trace[2234128] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:573; }","duration":"354.52104ms","start":"2026-04-16T06:10:31.23997Z","end":"2026-04-16T06:10:31.594491Z","steps":["trace[2234128] 'range keys from in-memory index tree' (duration: 354.319494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.594867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.189423215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.594911Z","caller":"traceutil/trace.go:171","msg":"trace[783092377] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"2.189484696s","start":"2026-04-16T06:10:29.405412Z","end":"2026-04-16T06:10:31.594897Z","steps":["trace[783092377] 'agreement among raft nodes before linearized reading' (duration: 1.501575218s)","trace[783092377] 'range keys from in-memory index tree' (duration: 687.858707ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:31.594946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:29.405397Z","time spent":"2.189542758s","remote":"127.0.0.1:41738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T06:10:31.595424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.239954Z","time spent":"354.589622ms","remote":"127.0.0.1:37830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:10:31.595499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.512917137s","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-16T06:10:31.595532Z","caller":"traceutil/trace.go:171","msg":"trace[1134363780] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"2.512964339s","start":"2026-04-16T06:10:29.082555Z","end":"2026-04-16T06:10:31.595519Z","steps":["trace[1134363780] 'agreement among raft nodes before linearized reading' (duration: 1.824280949s)","trace[1134363780] 'range keys from in-memory index tree' (duration: 688.614278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:31.595543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.595923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.595563Z","caller":"traceutil/trace.go:171","msg":"trace[1377734641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:573; }","duration":"316.616184ms","start":"2026-04-16T06:10:31.27894Z","end":"2026-04-16T06:10:31.595556Z","steps":["trace[1377734641] 'range keys from in-memory index tree' (duration: 316.49871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.595561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:29.082539Z","time spent":"2.51301522s","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T06:10:31.595579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.278899Z","time spent":"316.675235ms","remote":"127.0.0.1:37844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:10:31.595657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.717236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.595671Z","caller":"traceutil/trace.go:171","msg":"trace[688955477] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:573; }","duration":"316.757436ms","start":"2026-04-16T06:10:31.27891Z","end":"2026-04-16T06:10:31.595667Z","steps":["trace[688955477] 'count revisions from in-memory index tree' (duration: 316.609823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.595689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.278891Z","time spent":"316.793958ms","remote":"127.0.0.1:37844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:10:31.595743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.968466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:10:31.595742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.513159823s","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-16T06:10:31.595759Z","caller":"traceutil/trace.go:171","msg":"trace[428025034] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:573; }","duration":"316.019317ms","start":"2026-04-16T06:10:31.279736Z","end":"2026-04-16T06:10:31.595755Z","steps":["trace[428025034] 'range keys from in-memory index tree' (duration: 315.914935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.595773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.27972Z","time spent":"316.048818ms","remote":"127.0.0.1:37830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-16T06:10:31.595832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.611037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.59585Z","caller":"traceutil/trace.go:171","msg":"trace[1891124033] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"275.655999ms","start":"2026-04-16T06:10:31.320188Z","end":"2026-04-16T06:10:31.595844Z","steps":["trace[1891124033] 'range keys from in-memory index tree' (duration: 275.543396ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.59593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.667679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.595947Z","caller":"traceutil/trace.go:171","msg":"trace[848460650] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"275.71701ms","start":"2026-04-16T06:10:31.320226Z","end":"2026-04-16T06:10:31.595943Z","steps":["trace[848460650] 'count revisions from in-memory index tree' (duration: 275.615827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.595974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.025541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.596023Z","caller":"traceutil/trace.go:171","msg":"trace[390177186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"175.078343ms","start":"2026-04-16T06:10:31.420931Z","end":"2026-04-16T06:10:31.59601Z","steps":["trace[390177186] 'range keys from in-memory index tree' (duration: 174.952069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.595429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.454411567s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-16T06:10:31.596106Z","caller":"traceutil/trace.go:171","msg":"trace[1570099622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"2.455134886s","start":"2026-04-16T06:10:29.140964Z","end":"2026-04-16T06:10:31.596099Z","steps":["trace[1570099622] 'agreement among raft nodes before linearized reading' (duration: 1.765862031s)","trace[1570099622] 'range keys from in-memory index tree' (duration: 688.512595ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:31.596123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:29.140936Z","time spent":"2.455182296s","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T06:10:31.596131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.984051605s","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-16T06:10:31.596164Z","caller":"traceutil/trace.go:171","msg":"trace[1819003898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:573; }","duration":"1.984118666s","start":"2026-04-16T06:10:29.612035Z","end":"2026-04-16T06:10:31.596154Z","steps":["trace[1819003898] 'agreement among raft nodes before linearized reading' (duration: 1.29517012s)","trace[1819003898] 'range keys from in-memory index tree' (duration: 688.829393ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:31.596233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:29.612015Z","time spent":"1.984210729s","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:10:31.596272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.542225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.596317Z","caller":"traceutil/trace.go:171","msg":"trace[1217925646] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"255.611007ms","start":"2026-04-16T06:10:31.340696Z","end":"2026-04-16T06:10:31.596307Z","steps":["trace[1217925646] 'range keys from in-memory index tree' (duration: 255.490264ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:31.596397Z","caller":"traceutil/trace.go:171","msg":"trace[474768191] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:573; }","duration":"2.513203875s","start":"2026-04-16T06:10:29.082555Z","end":"2026-04-16T06:10:31.595759Z","steps":["trace[474768191] 'agreement among raft nodes before linearized reading' (duration: 1.824285459s)","trace[474768191] 'range keys from in-memory index tree' (duration: 688.855614ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:31.59643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.333923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.596454Z","caller":"traceutil/trace.go:171","msg":"trace[664263042] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:573; }","duration":"682.374844ms","start":"2026-04-16T06:10:30.914072Z","end":"2026-04-16T06:10:31.596447Z","steps":["trace[664263042] 'range keys from in-memory index tree' (duration: 682.299162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.428001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:10:31.596523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.155012ms","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-16T06:10:31.596554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.395729ms","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-16T06:10:31.596559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.245565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.59656Z","caller":"traceutil/trace.go:171","msg":"trace[368931405] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:573; }","duration":"526.276636ms","start":"2026-04-16T06:10:31.070274Z","end":"2026-04-16T06:10:31.59655Z","steps":["trace[368931405] 'count revisions from in-memory index tree' (duration: 526.06743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.59657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.462622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:10:31.596594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.904211ms","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-16T06:10:31.596605Z","caller":"traceutil/trace.go:171","msg":"trace[345220248] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:573; }","duration":"183.333648ms","start":"2026-04-16T06:10:31.413243Z","end":"2026-04-16T06:10:31.596576Z","steps":["trace[345220248] 'range keys from in-memory index tree' (duration: 183.123442ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.870461ms","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-16T06:10:31.596649Z","caller":"traceutil/trace.go:171","msg":"trace[802741940] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:573; }","duration":"236.956682ms","start":"2026-04-16T06:10:31.359689Z","end":"2026-04-16T06:10:31.596645Z","steps":["trace[802741940] 'range keys from in-memory index tree' (duration: 236.84107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.335348ms","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-16T06:10:31.596696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.41518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.59671Z","caller":"traceutil/trace.go:171","msg":"trace[2073904601] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:573; }","duration":"671.4192ms","start":"2026-04-16T06:10:30.925284Z","end":"2026-04-16T06:10:31.596704Z","steps":["trace[2073904601] 'count revisions from in-memory index tree' (duration: 671.166514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.634495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.59676Z","caller":"traceutil/trace.go:171","msg":"trace[1375682036] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:573; }","duration":"183.684207ms","start":"2026-04-16T06:10:31.413072Z","end":"2026-04-16T06:10:31.596756Z","steps":["trace[1375682036] 'range keys from in-memory index tree' (duration: 183.578584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.227066ms","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-16T06:10:31.59676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:30.925256Z","time spent":"671.497222ms","remote":"127.0.0.1:37792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:10:31.596578Z","caller":"traceutil/trace.go:171","msg":"trace[144766305] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:573; }","duration":"183.45229ms","start":"2026-04-16T06:10:31.41312Z","end":"2026-04-16T06:10:31.596572Z","steps":["trace[144766305] 'count revisions from in-memory index tree' (duration: 183.323337ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:31.596779Z","caller":"traceutil/trace.go:171","msg":"trace[1257043287] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:573; }","duration":"403.287807ms","start":"2026-04-16T06:10:31.193485Z","end":"2026-04-16T06:10:31.596773Z","steps":["trace[1257043287] 'count revisions from in-memory index tree' (duration: 403.173275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.193465Z","time spent":"403.332528ms","remote":"127.0.0.1:37824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"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-16T06:10:31.596454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:29.082541Z","time spent":"2.513898952s","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T06:10:31.596962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.209784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.596988Z","caller":"traceutil/trace.go:171","msg":"trace[1430569181] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:573; }","duration":"651.328538ms","start":"2026-04-16T06:10:30.945653Z","end":"2026-04-16T06:10:31.596982Z","steps":["trace[1430569181] 'range keys from in-memory index tree' (duration: 651.095172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.597009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:30.945629Z","time spent":"651.374028ms","remote":"127.0.0.1:37806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:10:31.59702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.266065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.597055Z","caller":"traceutil/trace.go:171","msg":"trace[1989684617] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:573; }","duration":"651.352948ms","start":"2026-04-16T06:10:30.945697Z","end":"2026-04-16T06:10:31.59705Z","steps":["trace[1989684617] 'count revisions from in-memory index tree' (duration: 651.157563ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.597075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:30.945677Z","time spent":"651.393889ms","remote":"127.0.0.1:37806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:10:31.597107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.581174ms","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-16T06:10:31.59715Z","caller":"traceutil/trace.go:171","msg":"trace[916503707] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:573; }","duration":"403.669636ms","start":"2026-04-16T06:10:31.19347Z","end":"2026-04-16T06:10:31.597139Z","steps":["trace[916503707] 'range keys from in-memory index tree' (duration: 403.343098ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"649.925861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.596612Z","caller":"traceutil/trace.go:171","msg":"trace[391633804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:573; }","duration":"236.941342ms","start":"2026-04-16T06:10:31.359667Z","end":"2026-04-16T06:10:31.596608Z","steps":["trace[391633804] 'count revisions from in-memory index tree' (duration: 236.8463ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:31.597285Z","caller":"traceutil/trace.go:171","msg":"trace[2061044192] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:573; }","duration":"651.216846ms","start":"2026-04-16T06:10:30.946057Z","end":"2026-04-16T06:10:31.597274Z","steps":["trace[2061044192] 'range keys from in-memory index tree' (duration: 649.872131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.070242Z","time spent":"526.338538ms","remote":"127.0.0.1:37810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"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-16T06:10:31.597313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:30.946049Z","time spent":"651.255566ms","remote":"127.0.0.1:37806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 "} {"level":"warn","ts":"2026-04-16T06:10:31.597387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.193453Z","time spent":"403.929594ms","remote":"127.0.0.1:37824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:10:31.5976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.800413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:10:31.597634Z","caller":"traceutil/trace.go:171","msg":"trace[144541326] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"153.214764ms","start":"2026-04-16T06:10:31.444414Z","end":"2026-04-16T06:10:31.597629Z","steps":["trace[144541326] 'read index received' (duration: 45.331049ms)","trace[144541326] 'applied index is now lower than readState.Index' (duration: 107.883085ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:31.597692Z","caller":"traceutil/trace.go:171","msg":"trace[2027017989] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"176.564371ms","start":"2026-04-16T06:10:31.421121Z","end":"2026-04-16T06:10:31.597685Z","steps":["trace[2027017989] 'process raft request' (duration: 68.653185ms)","trace[2027017989] 'compare' (duration: 106.268814ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:31.597787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.371468ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.597806Z","caller":"traceutil/trace.go:171","msg":"trace[1635853932] 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:574; }","duration":"153.41645ms","start":"2026-04-16T06:10:31.444384Z","end":"2026-04-16T06:10:31.597801Z","steps":["trace[1635853932] 'agreement among raft nodes before linearized reading' (duration: 153.370899ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.529403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:10:31.59788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.404059ms","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-16T06:10:31.597898Z","caller":"traceutil/trace.go:171","msg":"trace[1194634842] 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:574; }","duration":"153.43713ms","start":"2026-04-16T06:10:31.444456Z","end":"2026-04-16T06:10:31.597894Z","steps":["trace[1194634842] 'agreement among raft nodes before linearized reading' (duration: 153.412409ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:31.597888Z","caller":"traceutil/trace.go:171","msg":"trace[814484195] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:573; }","duration":"672.900508ms","start":"2026-04-16T06:10:30.924974Z","end":"2026-04-16T06:10:31.597875Z","steps":["trace[814484195] 'range keys from in-memory index tree' (duration: 671.457982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.597934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:30.924964Z","time spent":"672.955481ms","remote":"127.0.0.1:37792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:10:31.596492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.226823ms","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-16T06:10:31.59804Z","caller":"traceutil/trace.go:171","msg":"trace[836460372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:573; }","duration":"527.833056ms","start":"2026-04-16T06:10:31.0702Z","end":"2026-04-16T06:10:31.598033Z","steps":["trace[836460372] 'range keys from in-memory index tree' (duration: 526.051859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.59807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.070176Z","time spent":"527.885557ms","remote":"127.0.0.1:37810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T06:10:31.596458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.596646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.598205Z","caller":"traceutil/trace.go:171","msg":"trace[2017564142] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"257.369903ms","start":"2026-04-16T06:10:31.340818Z","end":"2026-04-16T06:10:31.598188Z","steps":["trace[2017564142] 'count revisions from in-memory index tree' (duration: 255.523894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:30.91406Z","time spent":"682.434726ms","remote":"127.0.0.1:42094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":27,"request content":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"warn","ts":"2026-04-16T06:10:31.598542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.041396ms","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-16T06:10:31.596527Z","caller":"traceutil/trace.go:171","msg":"trace[1403879305] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"255.472912ms","start":"2026-04-16T06:10:31.341046Z","end":"2026-04-16T06:10:31.596519Z","steps":["trace[1403879305] 'range keys from in-memory index tree' (duration: 255.38647ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:31.596602Z","caller":"traceutil/trace.go:171","msg":"trace[310066553] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:573; }","duration":"671.507323ms","start":"2026-04-16T06:10:30.925083Z","end":"2026-04-16T06:10:31.596591Z","steps":["trace[310066553] 'range keys from in-memory index tree' (duration: 671.39284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.596727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.444679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:31.596726Z","caller":"traceutil/trace.go:171","msg":"trace[1299464374] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:573; }","duration":"403.483003ms","start":"2026-04-16T06:10:31.193235Z","end":"2026-04-16T06:10:31.596718Z","steps":["trace[1299464374] 'range keys from in-memory index tree' (duration: 403.336118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.598578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:31.19322Z","time spent":"405.346431ms","remote":"127.0.0.1:37810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"info","ts":"2026-04-16T06:10:31.5987Z","caller":"traceutil/trace.go:171","msg":"trace[468920112] 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:574; }","duration":"154.208891ms","start":"2026-04-16T06:10:31.444483Z","end":"2026-04-16T06:10:31.598692Z","steps":["trace[468920112] 'agreement among raft nodes before linearized reading' (duration: 154.046996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:31.598805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:30.924983Z","time spent":"673.814913ms","remote":"127.0.0.1:37792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"info","ts":"2026-04-16T06:10:31.598841Z","caller":"traceutil/trace.go:171","msg":"trace[923407173] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:573; }","duration":"238.571844ms","start":"2026-04-16T06:10:31.360264Z","end":"2026-04-16T06:10:31.598836Z","steps":["trace[923407173] 'range keys from in-memory index tree' (duration: 236.399648ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:32.201098Z","caller":"traceutil/trace.go:171","msg":"trace[158515226] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"197.971099ms","start":"2026-04-16T06:10:32.003105Z","end":"2026-04-16T06:10:32.201076Z","steps":["trace[158515226] 'process raft request' (duration: 197.485586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:32.78769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.789517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:10:32.787772Z","caller":"traceutil/trace.go:171","msg":"trace[952109965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"116.918781ms","start":"2026-04-16T06:10:32.670832Z","end":"2026-04-16T06:10:32.787751Z","steps":["trace[952109965] 'range keys from in-memory index tree' (duration: 116.713136ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:32.793789Z","caller":"traceutil/trace.go:171","msg":"trace[49396650] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"101.90805ms","start":"2026-04-16T06:10:32.691846Z","end":"2026-04-16T06:10:32.793754Z","steps":["trace[49396650] 'process raft request' (duration: 101.1402ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:33.731429Z","caller":"traceutil/trace.go:171","msg":"trace[986881746] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"108.717418ms","start":"2026-04-16T06:10:33.622422Z","end":"2026-04-16T06:10:33.73114Z","steps":["trace[986881746] 'process raft request' (duration: 16.794857ms)","trace[986881746] 'compare' (duration: 91.767756ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:10:33.733485Z","caller":"traceutil/trace.go:171","msg":"trace[227865593] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"110.261248ms","start":"2026-04-16T06:10:33.623206Z","end":"2026-04-16T06:10:33.733467Z","steps":["trace[227865593] 'process raft request' (duration: 109.96535ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:33.73422Z","caller":"traceutil/trace.go:171","msg":"trace[1755659935] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"110.194836ms","start":"2026-04-16T06:10:33.623975Z","end":"2026-04-16T06:10:33.734169Z","steps":["trace[1755659935] 'process raft request' (duration: 109.424127ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:48.185126Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2398340064464377417,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T06:10:48.367229Z","caller":"traceutil/trace.go:171","msg":"trace[139171718] linearizableReadLoop","detail":"{readStateIndex:771; appliedIndex:770; }","duration":"682.90177ms","start":"2026-04-16T06:10:47.684312Z","end":"2026-04-16T06:10:48.367214Z","steps":["trace[139171718] 'read index received' (duration: 682.738236ms)","trace[139171718] 'applied index is now lower than readState.Index' (duration: 163.044µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:48.367493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.164187ms","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-16T06:10:48.36752Z","caller":"traceutil/trace.go:171","msg":"trace[542457300] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:744; }","duration":"683.234459ms","start":"2026-04-16T06:10:47.68428Z","end":"2026-04-16T06:10:48.367514Z","steps":["trace[542457300] 'agreement among raft nodes before linearized reading' (duration: 683.115086ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:48.367539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:47.684266Z","time spent":"683.26836ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T06:10:48.367605Z","caller":"traceutil/trace.go:171","msg":"trace[277163215] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"756.446198ms","start":"2026-04-16T06:10:47.611132Z","end":"2026-04-16T06:10:48.367578Z","steps":["trace[277163215] 'process raft request' (duration: 755.995766ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:48.367649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.69019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T06:10:48.367704Z","caller":"traceutil/trace.go:171","msg":"trace[1389665199] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:744; }","duration":"553.806282ms","start":"2026-04-16T06:10:47.813884Z","end":"2026-04-16T06:10:48.36769Z","steps":["trace[1389665199] 'agreement among raft nodes before linearized reading' (duration: 553.628448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:48.367748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:47.813863Z","time spent":"553.876524ms","remote":"127.0.0.1:42006","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-16T06:10:48.367731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.431301ms","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-16T06:10:48.367763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:47.611121Z","time spent":"756.56638ms","remote":"127.0.0.1:41914","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:10:48.367812Z","caller":"traceutil/trace.go:171","msg":"trace[869440353] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:744; }","duration":"556.544943ms","start":"2026-04-16T06:10:47.811249Z","end":"2026-04-16T06:10:48.367794Z","steps":["trace[869440353] 'agreement among raft nodes before linearized reading' (duration: 556.302567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:48.367887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:47.811238Z","time spent":"556.637626ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T06:10:48.368545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.327536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T06:10:48.368598Z","caller":"traceutil/trace.go:171","msg":"trace[1645074820] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:744; }","duration":"561.377538ms","start":"2026-04-16T06:10:47.807204Z","end":"2026-04-16T06:10:48.368581Z","steps":["trace[1645074820] 'agreement among raft nodes before linearized reading' (duration: 560.25978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:48.368629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:47.807126Z","time spent":"561.496091ms","remote":"127.0.0.1:42006","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-16T06:10:48.557644Z","caller":"traceutil/trace.go:171","msg":"trace[1974685628] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"184.783842ms","start":"2026-04-16T06:10:48.372832Z","end":"2026-04-16T06:10:48.557616Z","steps":["trace[1974685628] 'process raft request' (duration: 182.569235ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:48.558092Z","caller":"traceutil/trace.go:171","msg":"trace[128800161] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"184.860124ms","start":"2026-04-16T06:10:48.373215Z","end":"2026-04-16T06:10:48.558075Z","steps":["trace[128800161] 'process raft request' (duration: 184.829123ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:48.558215Z","caller":"traceutil/trace.go:171","msg":"trace[1750804716] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"185.296825ms","start":"2026-04-16T06:10:48.372839Z","end":"2026-04-16T06:10:48.558136Z","steps":["trace[1750804716] 'process raft request' (duration: 185.096341ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:10:48.55931Z","caller":"traceutil/trace.go:171","msg":"trace[7082840] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"186.395334ms","start":"2026-04-16T06:10:48.37288Z","end":"2026-04-16T06:10:48.559275Z","steps":["trace[7082840] 'process raft request' (duration: 185.138112ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:11:22.99773Z","caller":"traceutil/trace.go:171","msg":"trace[367807805] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"272.532327ms","start":"2026-04-16T06:11:22.725178Z","end":"2026-04-16T06:11:22.99771Z","steps":["trace[367807805] 'process raft request' (duration: 272.386263ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:23.909059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.031978ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:11:23.909173Z","caller":"traceutil/trace.go:171","msg":"trace[1522181225] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:988; }","duration":"1.176827568s","start":"2026-04-16T06:11:22.732334Z","end":"2026-04-16T06:11:23.909162Z","steps":["trace[1522181225] 'read index received' (duration: 265.238229ms)","trace[1522181225] 'applied index is now lower than readState.Index' (duration: 911.588369ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:11:23.909234Z","caller":"traceutil/trace.go:171","msg":"trace[80597958] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"1.081334742s","start":"2026-04-16T06:11:22.827892Z","end":"2026-04-16T06:11:23.909227Z","steps":["trace[80597958] 'process raft request' (duration: 1.081232089s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:23.90928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:11:22.827856Z","time spent":"1.081400714s","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:11:23.909274Z","caller":"traceutil/trace.go:171","msg":"trace[1358541547] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"1.180805742s","start":"2026-04-16T06:11:22.728424Z","end":"2026-04-16T06:11:23.90923Z","steps":["trace[1358541547] 'process raft request' (duration: 560.510886ms)","trace[1358541547] 'compare' (duration: 619.964677ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:11:23.90949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:11:22.728387Z","time spent":"1.181009307s","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:11:23.909564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177169707s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T06:11:23.90964Z","caller":"traceutil/trace.go:171","msg":"trace[1054599710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:956; }","duration":"1.177295099s","start":"2026-04-16T06:11:22.732322Z","end":"2026-04-16T06:11:23.909617Z","steps":["trace[1054599710] 'agreement among raft nodes before linearized reading' (duration: 1.177140546s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:23.909643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.984138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:11:23.909686Z","caller":"traceutil/trace.go:171","msg":"trace[1682486774] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:956; }","duration":"416.05189ms","start":"2026-04-16T06:11:23.493627Z","end":"2026-04-16T06:11:23.909679Z","steps":["trace[1682486774] 'agreement among raft nodes before linearized reading' (duration: 415.965337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:23.909712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:11:23.493614Z","time spent":"416.091632ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T06:11:23.909728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.437583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T06:11:23.909763Z","caller":"traceutil/trace.go:171","msg":"trace[445144207] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:956; }","duration":"907.501135ms","start":"2026-04-16T06:11:23.002253Z","end":"2026-04-16T06:11:23.909754Z","steps":["trace[445144207] 'agreement among raft nodes before linearized reading' (duration: 907.449894ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:23.909791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177467665s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-16T06:11:23.909797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:11:23.002239Z","time spent":"907.550346ms","remote":"127.0.0.1:41998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":29,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:11:23.90981Z","caller":"traceutil/trace.go:171","msg":"trace[795492439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:956; }","duration":"1.177506426s","start":"2026-04-16T06:11:22.732297Z","end":"2026-04-16T06:11:23.909803Z","steps":["trace[795492439] 'agreement among raft nodes before linearized reading' (duration: 1.177458005s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:23.909832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:11:22.732284Z","time spent":"1.177542017s","remote":"127.0.0.1:42006","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-16T06:11:23.909683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:11:22.732287Z","time spent":"1.177387543s","remote":"127.0.0.1:42006","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-16T06:11:23.90998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120365333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:11:23.913432Z","caller":"traceutil/trace.go:171","msg":"trace[56319155] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:956; }","duration":"1.123751202s","start":"2026-04-16T06:11:22.78956Z","end":"2026-04-16T06:11:23.913311Z","steps":["trace[56319155] 'agreement among raft nodes before linearized reading' (duration: 1.120395115s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:23.91354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:11:22.789529Z","time spent":"1.123968316s","remote":"127.0.0.1:41966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:11:45.288533Z","caller":"traceutil/trace.go:171","msg":"trace[1386930013] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"206.156317ms","start":"2026-04-16T06:11:45.082349Z","end":"2026-04-16T06:11:45.288505Z","steps":["trace[1386930013] 'process raft request' (duration: 205.949491ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:11:48.242724Z","caller":"traceutil/trace.go:171","msg":"trace[117313531] linearizableReadLoop","detail":"{readStateIndex:1075; appliedIndex:1074; }","duration":"157.440223ms","start":"2026-04-16T06:11:48.085258Z","end":"2026-04-16T06:11:48.242699Z","steps":["trace[117313531] 'read index received' (duration: 157.169707ms)","trace[117313531] 'applied index is now lower than readState.Index' (duration: 269.226µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:11:48.243064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.921073ms","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-16T06:11:48.243088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.738791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T06:11:48.243178Z","caller":"traceutil/trace.go:171","msg":"trace[298745671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1035; }","duration":"157.940146ms","start":"2026-04-16T06:11:48.085216Z","end":"2026-04-16T06:11:48.243157Z","steps":["trace[298745671] 'agreement among raft nodes before linearized reading' (duration: 157.606467ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:11:48.243149Z","caller":"traceutil/trace.go:171","msg":"trace[481117676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1035; }","duration":"124.057497ms","start":"2026-04-16T06:11:48.119077Z","end":"2026-04-16T06:11:48.243135Z","steps":["trace[481117676] 'agreement among raft nodes before linearized reading' (duration: 123.858132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:48.243262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.103891ms","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-16T06:11:48.243023Z","caller":"traceutil/trace.go:171","msg":"trace[230600285] transaction","detail":"{read_only:false; response_revision:1035; number_of_response:1; }","duration":"180.791188ms","start":"2026-04-16T06:11:48.062012Z","end":"2026-04-16T06:11:48.242803Z","steps":["trace[230600285] 'process raft request' (duration: 180.495901ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:11:48.24335Z","caller":"traceutil/trace.go:171","msg":"trace[543063497] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1035; }","duration":"111.264016ms","start":"2026-04-16T06:11:48.132065Z","end":"2026-04-16T06:11:48.243329Z","steps":["trace[543063497] 'agreement among raft nodes before linearized reading' (duration: 110.973939ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:11:48.490075Z","caller":"traceutil/trace.go:171","msg":"trace[2063682836] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"155.457871ms","start":"2026-04-16T06:11:48.334592Z","end":"2026-04-16T06:11:48.49005Z","steps":["trace[2063682836] 'process raft request' (duration: 155.301677ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:11:49.009587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.913362ms","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-16T06:11:49.009677Z","caller":"traceutil/trace.go:171","msg":"trace[112668068] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1040; }","duration":"234.046775ms","start":"2026-04-16T06:11:48.775611Z","end":"2026-04-16T06:11:49.009658Z","steps":["trace[112668068] 'count revisions from in-memory index tree' (duration: 233.763307ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:01.208805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.660784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T06:12:01.20888Z","caller":"traceutil/trace.go:171","msg":"trace[695591614] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1130; }","duration":"329.775507ms","start":"2026-04-16T06:12:00.879089Z","end":"2026-04-16T06:12:01.208865Z","steps":["trace[695591614] 'count revisions from in-memory index tree' (duration: 329.581302ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:01.208899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.534421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:12:01.20892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:00.879074Z","time spent":"329.836248ms","remote":"127.0.0.1:41844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":29,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-04-16T06:12:01.208926Z","caller":"traceutil/trace.go:171","msg":"trace[824615749] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1130; }","duration":"535.561931ms","start":"2026-04-16T06:12:00.673356Z","end":"2026-04-16T06:12:01.208918Z","steps":["trace[824615749] 'range keys from in-memory index tree' (duration: 535.464419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:01.20902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:00.673274Z","time spent":"535.735956ms","remote":"127.0.0.1:41740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T06:12:21.276861Z","caller":"traceutil/trace.go:171","msg":"trace[1438301264] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"100.702801ms","start":"2026-04-16T06:12:21.176137Z","end":"2026-04-16T06:12:21.27684Z","steps":["trace[1438301264] 'process raft request' (duration: 100.336911ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:22.544319Z","caller":"traceutil/trace.go:171","msg":"trace[1683391179] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"140.793166ms","start":"2026-04-16T06:12:22.403496Z","end":"2026-04-16T06:12:22.544289Z","steps":["trace[1683391179] 'process raft request' (duration: 140.624122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:23.721837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.955087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-16T06:12:23.721903Z","caller":"traceutil/trace.go:171","msg":"trace[1138949594] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1245; }","duration":"120.066629ms","start":"2026-04-16T06:12:23.601823Z","end":"2026-04-16T06:12:23.721889Z","steps":["trace[1138949594] 'range keys from in-memory index tree' (duration: 119.833784ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:24.147646Z","caller":"traceutil/trace.go:171","msg":"trace[1952268788] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"160.886505ms","start":"2026-04-16T06:12:23.986732Z","end":"2026-04-16T06:12:24.147618Z","steps":["trace[1952268788] 'process raft request' (duration: 95.412855ms)","trace[1952268788] 'compare' (duration: 65.352027ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:31.948307Z","caller":"traceutil/trace.go:171","msg":"trace[1720242529] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"129.987336ms","start":"2026-04-16T06:12:31.818283Z","end":"2026-04-16T06:12:31.94827Z","steps":["trace[1720242529] 'process raft request' (duration: 129.523355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.22084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.193827641s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T06:12:33.220919Z","caller":"traceutil/trace.go:171","msg":"trace[1453715940] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1301; }","duration":"1.193975505s","start":"2026-04-16T06:12:32.026925Z","end":"2026-04-16T06:12:33.220901Z","steps":["trace[1453715940] 'count revisions from in-memory index tree' (duration: 1.193749579s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.220968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.026908Z","time spent":"1.194043466s","remote":"127.0.0.1:38012","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:12:33.221071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.603638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-16T06:12:33.221133Z","caller":"traceutil/trace.go:171","msg":"trace[29040155] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1301; }","duration":"663.747902ms","start":"2026-04-16T06:12:32.557372Z","end":"2026-04-16T06:12:33.22112Z","steps":["trace[29040155] 'range keys from in-memory index tree' (duration: 663.479394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.221159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.557352Z","time spent":"663.802374ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-04-16T06:12:33.22118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.708429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:12:33.221247Z","caller":"traceutil/trace.go:171","msg":"trace[1018681459] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1301; }","duration":"922.826832ms","start":"2026-04-16T06:12:32.298405Z","end":"2026-04-16T06:12:33.221232Z","steps":["trace[1018681459] 'count revisions from in-memory index tree' (duration: 922.572526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.221279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.298384Z","time spent":"922.886874ms","remote":"127.0.0.1:38540","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-04-16T06:12:33.221636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.709923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:12:33.22168Z","caller":"traceutil/trace.go:171","msg":"trace[1427758840] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"556.295326ms","start":"2026-04-16T06:12:32.665377Z","end":"2026-04-16T06:12:33.221672Z","steps":["trace[1427758840] 'read index received' (duration: 417.363418ms)","trace[1427758840] 'applied index is now lower than readState.Index' (duration: 138.931008ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:33.221813Z","caller":"traceutil/trace.go:171","msg":"trace[2113772235] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"632.318931ms","start":"2026-04-16T06:12:32.589485Z","end":"2026-04-16T06:12:33.221804Z","steps":["trace[2113772235] 'process raft request' (duration: 493.388522ms)","trace[2113772235] 'compare' (duration: 138.045546ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:12:33.221853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.589471Z","time spent":"632.361292ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:12:33.22209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.715732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:12:33.222152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.33313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-16T06:12:33.222158Z","caller":"traceutil/trace.go:171","msg":"trace[574973453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1302; }","duration":"548.822104ms","start":"2026-04-16T06:12:32.673318Z","end":"2026-04-16T06:12:33.22214Z","steps":["trace[574973453] 'agreement among raft nodes before linearized reading' (duration: 548.689581ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:33.222201Z","caller":"traceutil/trace.go:171","msg":"trace[1398119032] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1302; }","duration":"335.396562ms","start":"2026-04-16T06:12:32.886774Z","end":"2026-04-16T06:12:33.22217Z","steps":["trace[1398119032] 'agreement among raft nodes before linearized reading' (duration: 335.286499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.222181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.875844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-16T06:12:33.222215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"556.8326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-16T06:12:33.222227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.886754Z","time spent":"335.466723ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-16T06:12:33.222256Z","caller":"traceutil/trace.go:171","msg":"trace[351870227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1302; }","duration":"556.902222ms","start":"2026-04-16T06:12:32.665344Z","end":"2026-04-16T06:12:33.222247Z","steps":["trace[351870227] 'agreement among raft nodes before linearized reading' (duration: 556.601455ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:33.222252Z","caller":"traceutil/trace.go:171","msg":"trace[580189050] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1302; }","duration":"534.968356ms","start":"2026-04-16T06:12:32.687266Z","end":"2026-04-16T06:12:33.222234Z","steps":["trace[580189050] 'agreement among raft nodes before linearized reading' (duration: 534.802502ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.222275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.665332Z","time spent":"556.937812ms","remote":"127.0.0.1:42006","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-16T06:12:33.222306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.687255Z","time spent":"535.037638ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T06:12:33.222316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.430175ms","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-16T06:12:33.222358Z","caller":"traceutil/trace.go:171","msg":"trace[364619095] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1302; }","duration":"538.498067ms","start":"2026-04-16T06:12:32.683847Z","end":"2026-04-16T06:12:33.222345Z","steps":["trace[364619095] 'agreement among raft nodes before linearized reading' (duration: 538.383174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.222403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.683837Z","time spent":"538.556068ms","remote":"127.0.0.1:42006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T06:12:33.222439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"539.267126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-16T06:12:33.222207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.673288Z","time spent":"548.908466ms","remote":"127.0.0.1:41740","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T06:12:33.222463Z","caller":"traceutil/trace.go:171","msg":"trace[71556972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1302; }","duration":"539.303358ms","start":"2026-04-16T06:12:32.683153Z","end":"2026-04-16T06:12:33.222457Z","steps":["trace[71556972] 'agreement among raft nodes before linearized reading' (duration: 539.250687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:33.222477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:32.683146Z","time spent":"539.329168ms","remote":"127.0.0.1:42006","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-16T06:12:33.37666Z","caller":"traceutil/trace.go:171","msg":"trace[1121658513] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"150.895467ms","start":"2026-04-16T06:12:33.225751Z","end":"2026-04-16T06:12:33.376647Z","steps":["trace[1121658513] 'process raft request' (duration: 150.278111ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:33.37923Z","caller":"traceutil/trace.go:171","msg":"trace[940898198] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"153.34253ms","start":"2026-04-16T06:12:33.225861Z","end":"2026-04-16T06:12:33.379203Z","steps":["trace[940898198] 'process raft request' (duration: 153.174486ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:33.379236Z","caller":"traceutil/trace.go:171","msg":"trace[251934514] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"152.151629ms","start":"2026-04-16T06:12:33.227062Z","end":"2026-04-16T06:12:33.379214Z","steps":["trace[251934514] 'process raft request' (duration: 152.061567ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:33.379536Z","caller":"traceutil/trace.go:171","msg":"trace[1106101417] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"152.394256ms","start":"2026-04-16T06:12:33.227131Z","end":"2026-04-16T06:12:33.379525Z","steps":["trace[1106101417] 'process raft request' (duration: 152.029316ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:33.379575Z","caller":"traceutil/trace.go:171","msg":"trace[1038637328] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"152.241662ms","start":"2026-04-16T06:12:33.227328Z","end":"2026-04-16T06:12:33.379569Z","steps":["trace[1038637328] 'process raft request' (duration: 152.110799ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:33.379552Z","caller":"traceutil/trace.go:171","msg":"trace[1913704508] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"151.81533ms","start":"2026-04-16T06:12:33.22773Z","end":"2026-04-16T06:12:33.379545Z","steps":["trace[1913704508] 'process raft request' (duration: 151.782539ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:43.612304Z","caller":"traceutil/trace.go:171","msg":"trace[300681434] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"126.64644ms","start":"2026-04-16T06:12:43.485626Z","end":"2026-04-16T06:12:43.612273Z","steps":["trace[300681434] 'process raft request' (duration: 126.485517ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:43.636514Z","caller":"traceutil/trace.go:171","msg":"trace[1729228190] linearizableReadLoop","detail":"{readStateIndex:1404; appliedIndex:1402; }","duration":"150.600489ms","start":"2026-04-16T06:12:43.485894Z","end":"2026-04-16T06:12:43.636494Z","steps":["trace[1729228190] 'read index received' (duration: 126.321252ms)","trace[1729228190] 'applied index is now lower than readState.Index' (duration: 24.277997ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:43.636618Z","caller":"traceutil/trace.go:171","msg":"trace[1331248497] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"147.000007ms","start":"2026-04-16T06:12:43.489582Z","end":"2026-04-16T06:12:43.636582Z","steps":["trace[1331248497] 'process raft request' (duration: 146.868943ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:43.636903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.989369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T06:12:43.636727Z","caller":"traceutil/trace.go:171","msg":"trace[994944274] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"150.963799ms","start":"2026-04-16T06:12:43.485703Z","end":"2026-04-16T06:12:43.636667Z","steps":["trace[994944274] 'process raft request' (duration: 150.65045ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:43.636973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.067111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-16T06:12:43.637132Z","caller":"traceutil/trace.go:171","msg":"trace[1832936480] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1352; }","duration":"146.202414ms","start":"2026-04-16T06:12:43.490864Z","end":"2026-04-16T06:12:43.637066Z","steps":["trace[1832936480] 'agreement among raft nodes before linearized reading' (duration: 145.971309ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:43.636959Z","caller":"traceutil/trace.go:171","msg":"trace[893137609] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1352; }","duration":"151.072841ms","start":"2026-04-16T06:12:43.485873Z","end":"2026-04-16T06:12:43.636946Z","steps":["trace[893137609] 'agreement among raft nodes before linearized reading' (duration: 150.757144ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:43.818755Z","caller":"traceutil/trace.go:171","msg":"trace[1628380647] linearizableReadLoop","detail":"{readStateIndex:1407; appliedIndex:1405; }","duration":"138.315653ms","start":"2026-04-16T06:12:43.680418Z","end":"2026-04-16T06:12:43.818734Z","steps":["trace[1628380647] 'read index received' (duration: 59.893578ms)","trace[1628380647] 'applied index is now lower than readState.Index' (duration: 78.421075ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:43.818847Z","caller":"traceutil/trace.go:171","msg":"trace[1806624826] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"176.57274ms","start":"2026-04-16T06:12:43.64225Z","end":"2026-04-16T06:12:43.818823Z","steps":["trace[1806624826] 'process raft request' (duration: 98.106084ms)","trace[1806624826] 'compare' (duration: 78.004784ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:43.818894Z","caller":"traceutil/trace.go:171","msg":"trace[2123390145] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"175.493262ms","start":"2026-04-16T06:12:43.643387Z","end":"2026-04-16T06:12:43.81888Z","steps":["trace[2123390145] 'process raft request' (duration: 175.225786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:43.81908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.64484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:12:43.819127Z","caller":"traceutil/trace.go:171","msg":"trace[1727423833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1354; }","duration":"138.739983ms","start":"2026-04-16T06:12:43.680373Z","end":"2026-04-16T06:12:43.819113Z","steps":["trace[1727423833] 'agreement among raft nodes before linearized reading' (duration: 138.659131ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:44.125993Z","caller":"traceutil/trace.go:171","msg":"trace[236013453] linearizableReadLoop","detail":"{readStateIndex:1410; appliedIndex:1409; }","duration":"112.029304ms","start":"2026-04-16T06:12:44.013945Z","end":"2026-04-16T06:12:44.125974Z","steps":["trace[236013453] 'read index received' (duration: 111.86965ms)","trace[236013453] 'applied index is now lower than readState.Index' (duration: 158.914µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:44.126041Z","caller":"traceutil/trace.go:171","msg":"trace[834398438] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"249.231857ms","start":"2026-04-16T06:12:43.87678Z","end":"2026-04-16T06:12:44.126012Z","steps":["trace[834398438] 'process raft request' (duration: 249.039092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:44.126782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.832104ms","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-16T06:12:44.126821Z","caller":"traceutil/trace.go:171","msg":"trace[674235155] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1356; }","duration":"112.927126ms","start":"2026-04-16T06:12:44.013884Z","end":"2026-04-16T06:12:44.126811Z","steps":["trace[674235155] 'agreement among raft nodes before linearized reading' (duration: 112.216288ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:44.445Z","caller":"traceutil/trace.go:171","msg":"trace[1004510676] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"225.274197ms","start":"2026-04-16T06:12:44.219696Z","end":"2026-04-16T06:12:44.44497Z","steps":["trace[1004510676] 'process raft request' (duration: 161.716136ms)","trace[1004510676] 'compare' (duration: 63.479969ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:46.646909Z","caller":"traceutil/trace.go:171","msg":"trace[1054780824] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"106.592693ms","start":"2026-04-16T06:12:46.540287Z","end":"2026-04-16T06:12:46.64688Z","steps":["trace[1054780824] 'process raft request' (duration: 106.430268ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:47.52259Z","caller":"traceutil/trace.go:171","msg":"trace[859102293] linearizableReadLoop","detail":"{readStateIndex:1422; appliedIndex:1421; }","duration":"134.139994ms","start":"2026-04-16T06:12:47.388427Z","end":"2026-04-16T06:12:47.522566Z","steps":["trace[859102293] 'read index received' (duration: 133.842107ms)","trace[859102293] 'applied index is now lower than readState.Index' (duration: 296.357µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:12:47.522736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.294278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:12:47.522734Z","caller":"traceutil/trace.go:171","msg":"trace[1856102800] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"166.385067ms","start":"2026-04-16T06:12:47.35631Z","end":"2026-04-16T06:12:47.522695Z","steps":["trace[1856102800] 'process raft request' (duration: 166.074398ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:47.522782Z","caller":"traceutil/trace.go:171","msg":"trace[607263045] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1368; }","duration":"134.402951ms","start":"2026-04-16T06:12:47.388367Z","end":"2026-04-16T06:12:47.52277Z","steps":["trace[607263045] 'agreement among raft nodes before linearized reading' (duration: 134.304488ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:57.872178Z","caller":"traceutil/trace.go:171","msg":"trace[1975466206] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"135.095202ms","start":"2026-04-16T06:12:57.737043Z","end":"2026-04-16T06:12:57.872138Z","steps":["trace[1975466206] 'process raft request' (duration: 95.950583ms)","trace[1975466206] 'compare' (duration: 38.802879ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:13:03.910876Z","caller":"traceutil/trace.go:171","msg":"trace[998423757] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"159.236893ms","start":"2026-04-16T06:13:03.75159Z","end":"2026-04-16T06:13:03.910826Z","steps":["trace[998423757] 'process raft request' (duration: 158.549075ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:13:32.615522Z","caller":"traceutil/trace.go:171","msg":"trace[7036411] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"167.001393ms","start":"2026-04-16T06:13:32.448489Z","end":"2026-04-16T06:13:32.61549Z","steps":["trace[7036411] 'process raft request' (duration: 164.801177ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:13:42.63343Z","caller":"traceutil/trace.go:171","msg":"trace[1551927556] transaction","detail":"{read_only:false; response_revision:1622; number_of_response:1; }","duration":"119.218183ms","start":"2026-04-16T06:13:42.514179Z","end":"2026-04-16T06:13:42.633397Z","steps":["trace[1551927556] 'process raft request' (duration: 117.793726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:13:53.934411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.571453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T06:13:53.934495Z","caller":"traceutil/trace.go:171","msg":"trace[1089779303] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:1670; }","duration":"100.697495ms","start":"2026-04-16T06:13:53.833778Z","end":"2026-04-16T06:13:53.934476Z","steps":["trace[1089779303] 'range keys from in-memory index tree' (duration: 100.420678ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:13:56.763719Z","caller":"traceutil/trace.go:171","msg":"trace[779956498] transaction","detail":"{read_only:false; response_revision:1685; number_of_response:1; }","duration":"112.772636ms","start":"2026-04-16T06:13:56.650915Z","end":"2026-04-16T06:13:56.763687Z","steps":["trace[779956498] 'process raft request' (duration: 112.577191ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:13:59.318807Z","caller":"traceutil/trace.go:171","msg":"trace[1943402450] linearizableReadLoop","detail":"{readStateIndex:1766; appliedIndex:1765; }","duration":"145.253001ms","start":"2026-04-16T06:13:59.173508Z","end":"2026-04-16T06:13:59.318761Z","steps":["trace[1943402450] 'read index received' (duration: 65.973749ms)","trace[1943402450] 'applied index is now lower than readState.Index' (duration: 79.276842ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:13:59.319372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.819574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-16T06:13:59.319424Z","caller":"traceutil/trace.go:171","msg":"trace[1725613281] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1697; }","duration":"145.929077ms","start":"2026-04-16T06:13:59.173478Z","end":"2026-04-16T06:13:59.319407Z","steps":["trace[1725613281] 'agreement among raft nodes before linearized reading' (duration: 145.459795ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:02.621098Z","caller":"traceutil/trace.go:171","msg":"trace[687464330] transaction","detail":"{read_only:false; response_revision:1710; number_of_response:1; }","duration":"115.34591ms","start":"2026-04-16T06:14:02.50572Z","end":"2026-04-16T06:14:02.621066Z","steps":["trace[687464330] 'process raft request' (duration: 115.049812ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:02.794921Z","caller":"traceutil/trace.go:171","msg":"trace[339000060] transaction","detail":"{read_only:false; response_revision:1712; number_of_response:1; }","duration":"170.233673ms","start":"2026-04-16T06:14:02.624674Z","end":"2026-04-16T06:14:02.794907Z","steps":["trace[339000060] 'process raft request' (duration: 170.10798ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:02.794938Z","caller":"traceutil/trace.go:171","msg":"trace[1494118738] transaction","detail":"{read_only:false; response_revision:1711; number_of_response:1; }","duration":"170.288054ms","start":"2026-04-16T06:14:02.62461Z","end":"2026-04-16T06:14:02.794898Z","steps":["trace[1494118738] 'process raft request' (duration: 114.714313ms)","trace[1494118738] 'compare' (duration: 55.113379ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:14:15.053955Z","caller":"traceutil/trace.go:171","msg":"trace[1962417986] transaction","detail":"{read_only:false; response_revision:1769; number_of_response:1; }","duration":"146.694517ms","start":"2026-04-16T06:14:14.907226Z","end":"2026-04-16T06:14:15.05392Z","steps":["trace[1962417986] 'process raft request' (duration: 141.443842ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:15.054154Z","caller":"traceutil/trace.go:171","msg":"trace[948568033] transaction","detail":"{read_only:false; response_revision:1770; number_of_response:1; }","duration":"145.562838ms","start":"2026-04-16T06:14:14.908571Z","end":"2026-04-16T06:14:15.054133Z","steps":["trace[948568033] 'process raft request' (duration: 144.915021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:14:33.447047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.149921ms","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-16T06:14:33.447154Z","caller":"traceutil/trace.go:171","msg":"trace[8463806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1851; }","duration":"191.284744ms","start":"2026-04-16T06:14:33.255849Z","end":"2026-04-16T06:14:33.447134Z","steps":["trace[8463806] 'range keys from in-memory index tree' (duration: 190.963037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:14:33.447146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.740047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-16T06:14:33.447412Z","caller":"traceutil/trace.go:171","msg":"trace[24059071] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1851; }","duration":"192.079894ms","start":"2026-04-16T06:14:33.255314Z","end":"2026-04-16T06:14:33.447393Z","steps":["trace[24059071] 'range keys from in-memory index tree' (duration: 191.550042ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:33.877535Z","caller":"traceutil/trace.go:171","msg":"trace[1362338913] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"128.53632ms","start":"2026-04-16T06:14:33.748963Z","end":"2026-04-16T06:14:33.877499Z","steps":["trace[1362338913] 'process raft request' (duration: 128.293703ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:14:41.332445Z","caller":"traceutil/trace.go:171","msg":"trace[426805140] transaction","detail":"{read_only:false; response_revision:1888; number_of_response:1; }","duration":"114.551449ms","start":"2026-04-16T06:14:41.217862Z","end":"2026-04-16T06:14:41.332414Z","steps":["trace[426805140] 'process raft request' (duration: 88.346355ms)","trace[426805140] 'compare' (duration: 26.088092ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:14:59.209283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.052499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:14:59.209421Z","caller":"traceutil/trace.go:171","msg":"trace[908197135] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"223.391432ms","start":"2026-04-16T06:14:58.986016Z","end":"2026-04-16T06:14:59.209407Z","steps":["trace[908197135] 'process raft request' (duration: 86.151498ms)","trace[908197135] 'compare' (duration: 136.952217ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:15:21.832255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.124378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-16T06:15:21.832372Z","caller":"traceutil/trace.go:171","msg":"trace[571714916] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2073; }","duration":"101.250221ms","start":"2026-04-16T06:15:21.731098Z","end":"2026-04-16T06:15:21.832349Z","steps":["trace[571714916] 'range keys from in-memory index tree' (duration: 100.955193ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:15:23.670854Z","caller":"traceutil/trace.go:171","msg":"trace[1071933725] transaction","detail":"{read_only:false; response_revision:2081; number_of_response:1; }","duration":"150.179472ms","start":"2026-04-16T06:15:23.520653Z","end":"2026-04-16T06:15:23.670833Z","steps":["trace[1071933725] 'process raft request' (duration: 149.599068ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:15:28.910337Z","caller":"traceutil/trace.go:171","msg":"trace[931377317] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"199.910435ms","start":"2026-04-16T06:15:28.710389Z","end":"2026-04-16T06:15:28.9103Z","steps":["trace[931377317] 'process raft request' (duration: 199.594448ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:15:41.581361Z","caller":"traceutil/trace.go:171","msg":"trace[1622632885] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"117.768487ms","start":"2026-04-16T06:15:41.46356Z","end":"2026-04-16T06:15:41.581329Z","steps":["trace[1622632885] 'process raft request' (duration: 117.591093ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:15:41.582078Z","caller":"traceutil/trace.go:171","msg":"trace[613726694] linearizableReadLoop","detail":"{readStateIndex:2272; appliedIndex:2272; }","duration":"102.085501ms","start":"2026-04-16T06:15:41.479963Z","end":"2026-04-16T06:15:41.582048Z","steps":["trace[613726694] 'read index received' (duration: 102.071621ms)","trace[613726694] 'applied index is now lower than readState.Index' (duration: 10.81µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:15:41.582414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.438231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-16T06:15:41.582463Z","caller":"traceutil/trace.go:171","msg":"trace[1044875230] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2182; }","duration":"102.561235ms","start":"2026-04-16T06:15:41.479888Z","end":"2026-04-16T06:15:41.582449Z","steps":["trace[1044875230] 'agreement among raft nodes before linearized reading' (duration: 102.306789ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:16:20.198664Z","caller":"traceutil/trace.go:171","msg":"trace[914448789] linearizableReadLoop","detail":"{readStateIndex:2475; appliedIndex:2474; }","duration":"208.379518ms","start":"2026-04-16T06:16:19.990244Z","end":"2026-04-16T06:16:20.198624Z","steps":["trace[914448789] 'read index received' (duration: 112.556746ms)","trace[914448789] 'applied index is now lower than readState.Index' (duration: 95.821102ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:16:20.198725Z","caller":"traceutil/trace.go:171","msg":"trace[562806102] transaction","detail":"{read_only:false; response_revision:2377; number_of_response:1; }","duration":"249.578493ms","start":"2026-04-16T06:16:19.949127Z","end":"2026-04-16T06:16:20.198705Z","steps":["trace[562806102] 'process raft request' (duration: 153.76509ms)","trace[562806102] 'compare' (duration: 95.494004ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:16:20.19898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.796008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-04-16T06:16:20.199038Z","caller":"traceutil/trace.go:171","msg":"trace[2011772239] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:2377; }","duration":"189.86108ms","start":"2026-04-16T06:16:20.009163Z","end":"2026-04-16T06:16:20.199024Z","steps":["trace[2011772239] 'agreement among raft nodes before linearized reading' (duration: 189.766697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:20.199312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.009014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-04-16T06:16:20.199371Z","caller":"traceutil/trace.go:171","msg":"trace[1143126225] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2377; }","duration":"209.139839ms","start":"2026-04-16T06:16:19.990215Z","end":"2026-04-16T06:16:20.199355Z","steps":["trace[1143126225] 'agreement among raft nodes before linearized reading' (duration: 208.573194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:20.199574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.284368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-16T06:16:20.199627Z","caller":"traceutil/trace.go:171","msg":"trace[899574233] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:2377; }","duration":"186.389161ms","start":"2026-04-16T06:16:20.013224Z","end":"2026-04-16T06:16:20.199613Z","steps":["trace[899574233] 'agreement among raft nodes before linearized reading' (duration: 186.250868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:20.199759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.097406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T06:16:20.199808Z","caller":"traceutil/trace.go:171","msg":"trace[1479450996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2377; }","duration":"109.178728ms","start":"2026-04-16T06:16:20.090614Z","end":"2026-04-16T06:16:20.199793Z","steps":["trace[1479450996] 'agreement among raft nodes before linearized reading' (duration: 109.055285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:20.507346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.429901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363690"} {"level":"info","ts":"2026-04-16T06:16:20.507401Z","caller":"traceutil/trace.go:171","msg":"trace[1163693115] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2381; }","duration":"208.520143ms","start":"2026-04-16T06:16:20.298868Z","end":"2026-04-16T06:16:20.507388Z","steps":["trace[1163693115] 'range keys from in-memory index tree' (duration: 208.219815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:20.507799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.438217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:6 size:363690"} {"level":"info","ts":"2026-04-16T06:16:20.508131Z","caller":"traceutil/trace.go:171","msg":"trace[1121738624] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:6; response_revision:2381; }","duration":"209.813987ms","start":"2026-04-16T06:16:20.298298Z","end":"2026-04-16T06:16:20.508112Z","steps":["trace[1121738624] 'range keys from in-memory index tree' (duration: 208.597475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:21.410661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.523107ms","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-16T06:16:21.410772Z","caller":"traceutil/trace.go:171","msg":"trace[286809121] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:2383; }","duration":"109.64308ms","start":"2026-04-16T06:16:21.301082Z","end":"2026-04-16T06:16:21.410725Z","steps":["trace[286809121] 'range keys from in-memory index tree' (duration: 109.437355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:21.411296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.75277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-04-16T06:16:21.411589Z","caller":"traceutil/trace.go:171","msg":"trace[611119847] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:1; response_revision:2383; }","duration":"125.062548ms","start":"2026-04-16T06:16:21.286502Z","end":"2026-04-16T06:16:21.411565Z","steps":["trace[611119847] 'range keys from in-memory index tree' (duration: 124.133595ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:16:22.427877Z","caller":"traceutil/trace.go:171","msg":"trace[1426783172] linearizableReadLoop","detail":"{readStateIndex:2486; appliedIndex:2485; }","duration":"155.780002ms","start":"2026-04-16T06:16:22.272068Z","end":"2026-04-16T06:16:22.427848Z","steps":["trace[1426783172] 'read index received' (duration: 152.086095ms)","trace[1426783172] 'applied index is now lower than readState.Index' (duration: 3.692666ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:16:22.428Z","caller":"traceutil/trace.go:171","msg":"trace[2064951618] transaction","detail":"{read_only:false; response_revision:2388; number_of_response:1; }","duration":"180.672384ms","start":"2026-04-16T06:16:22.247258Z","end":"2026-04-16T06:16:22.427931Z","steps":["trace[2064951618] 'process raft request' (duration: 177.020109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:22.428117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.80575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-04-16T06:16:22.428146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.066648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-controller\" ","response":"range_response_count:1 size:201"} {"level":"warn","ts":"2026-04-16T06:16:22.428168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.271667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T06:16:22.428191Z","caller":"traceutil/trace.go:171","msg":"trace[1129648644] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:1; response_revision:2388; }","duration":"134.926533ms","start":"2026-04-16T06:16:22.293244Z","end":"2026-04-16T06:16:22.42817Z","steps":["trace[1129648644] 'agreement among raft nodes before linearized reading' (duration: 134.78844ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:16:22.428212Z","caller":"traceutil/trace.go:171","msg":"trace[674298899] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-controller; range_end:; response_count:1; response_revision:2388; }","duration":"156.164751ms","start":"2026-04-16T06:16:22.272031Z","end":"2026-04-16T06:16:22.428195Z","steps":["trace[674298899] 'agreement among raft nodes before linearized reading' (duration: 156.055728ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:16:22.42822Z","caller":"traceutil/trace.go:171","msg":"trace[1201623312] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2388; }","duration":"129.342939ms","start":"2026-04-16T06:16:22.29886Z","end":"2026-04-16T06:16:22.428203Z","steps":["trace[1201623312] 'agreement among raft nodes before linearized reading' (duration: 129.176985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:16:22.428389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.403946ms","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-16T06:16:22.428404Z","caller":"traceutil/trace.go:171","msg":"trace[640853393] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2388; }","duration":"130.449007ms","start":"2026-04-16T06:16:22.29795Z","end":"2026-04-16T06:16:22.428399Z","steps":["trace[640853393] 'agreement among raft nodes before linearized reading' (duration: 130.375895ms)"],"step_count":1}