{"level":"warn","ts":"2026-04-16T10:06:52.420432Z","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-16T10:06:52.420537Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-16T10:06:52.420626Z","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-16T10:06:52.420639Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-16T10:06:52.420667Z","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-16T10:06:52.421468Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-04-16T10:06:52.42159Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-16T10:06:52.426995Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.110838ms"} {"level":"info","ts":"2026-04-16T10:06:52.440143Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-04-16T10:06:52.440225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T10:06:52.440248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-04-16T10:06:52.440262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T10:06:52.440271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-04-16T10:06:52.440315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-04-16T10:06:52.450573Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T10:06:52.452169Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T10:06:52.453962Z","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-16T10:06:52.456384Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T10:06:52.456777Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T10:06:52.456853Z","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-16T10:06:52.456945Z","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-16T10:06:52.456955Z","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-16T10:06:52.458696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-04-16T10:06:52.458838Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-16T10:06:52.46076Z","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-16T10:06:52.460862Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-16T10:06:52.460905Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-16T10:06:52.461033Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T10:06:52.46108Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T10:06:53.240526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T10:06:53.240569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T10:06:53.2406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-04-16T10:06:53.24061Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-04-16T10:06:53.240615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-16T10:06:53.240625Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-04-16T10:06:53.240632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-16T10:06:53.242549Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T10:06:53.243338Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T10:06:53.243333Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T10:06:53.243529Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T10:06:53.243888Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T10:06:53.243946Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T10:06:53.243963Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T10:06:53.24535Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-04-16T10:06:53.246156Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T10:06:53.246581Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T10:06:53.246738Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-04-16T10:06:56.10186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.31779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-16T10:06:56.101953Z","caller":"traceutil/trace.go:171","msg":"trace[1208627933] transaction","detail":"{read_only:false; response_revision:95; number_of_response:1; }","duration":"265.184051ms","start":"2026-04-16T10:06:55.836755Z","end":"2026-04-16T10:06:56.101939Z","steps":["trace[1208627933] 'process raft request' (duration: 90.383604ms)","trace[1208627933] 'compare' (duration: 174.174828ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:06:58.070388Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967603957302303210,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T10:06:58.371466Z","caller":"traceutil/trace.go:171","msg":"trace[694224103] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"909.151072ms","start":"2026-04-16T10:06:57.462288Z","end":"2026-04-16T10:06:58.371439Z","steps":["trace[694224103] 'process raft request' (duration: 909.01348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:58.371621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:57.462266Z","time spent":"909.288043ms","remote":"127.0.0.1:33898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T10:06:58.412305Z","caller":"traceutil/trace.go:171","msg":"trace[2141914724] linearizableReadLoop","detail":"{readStateIndex:211; appliedIndex:209; }","duration":"842.825567ms","start":"2026-04-16T10:06:57.569451Z","end":"2026-04-16T10:06:58.412277Z","steps":["trace[2141914724] 'read index received' (duration: 801.900609ms)","trace[2141914724] 'applied index is now lower than readState.Index' (duration: 40.923618ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:06:58.412392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:57.518955Z","time spent":"893.420933ms","remote":"127.0.0.1:33794","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-16T10:06:58.41254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.104758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T10:06:58.412556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"843.098801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"warn","ts":"2026-04-16T10:06:58.412596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.991223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:06:58.412623Z","caller":"traceutil/trace.go:171","msg":"trace[1544078414] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:205; }","duration":"843.165202ms","start":"2026-04-16T10:06:57.569434Z","end":"2026-04-16T10:06:58.412599Z","steps":["trace[1544078414] 'agreement among raft nodes before linearized reading' (duration: 843.02876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:58.412651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.072118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:06:58.412663Z","caller":"traceutil/trace.go:171","msg":"trace[2084155595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:205; }","duration":"227.078405ms","start":"2026-04-16T10:06:58.185568Z","end":"2026-04-16T10:06:58.412646Z","steps":["trace[2084155595] 'agreement among raft nodes before linearized reading' (duration: 226.981284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:58.412675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:57.569369Z","time spent":"843.294594ms","remote":"127.0.0.1:33892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3514,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-16T10:06:58.412694Z","caller":"traceutil/trace.go:171","msg":"trace[374213271] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:205; }","duration":"561.14055ms","start":"2026-04-16T10:06:57.851537Z","end":"2026-04-16T10:06:58.412678Z","steps":["trace[374213271] 'agreement among raft nodes before linearized reading' (duration: 561.067079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:58.412728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:57.851517Z","time spent":"561.20397ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"info","ts":"2026-04-16T10:06:58.412859Z","caller":"traceutil/trace.go:171","msg":"trace[1389649964] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:205; }","duration":"757.22935ms","start":"2026-04-16T10:06:57.655342Z","end":"2026-04-16T10:06:58.412571Z","steps":["trace[1389649964] 'agreement among raft nodes before linearized reading' (duration: 757.117269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:58.412895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:57.655319Z","time spent":"757.568644ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T10:06:59.725179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.084653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T10:06:59.725298Z","caller":"traceutil/trace.go:171","msg":"trace[1835004410] linearizableReadLoop","detail":"{readStateIndex:212; appliedIndex:211; }","duration":"1.309556659s","start":"2026-04-16T10:06:58.415719Z","end":"2026-04-16T10:06:59.725276Z","steps":["trace[1835004410] 'read index received' (duration: 407.312214ms)","trace[1835004410] 'applied index is now lower than readState.Index' (duration: 902.242155ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:06:59.725379Z","caller":"traceutil/trace.go:171","msg":"trace[1829962680] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"1.311314282s","start":"2026-04-16T10:06:58.414051Z","end":"2026-04-16T10:06:59.725365Z","steps":["trace[1829962680] 'process raft request' (duration: 408.959276ms)","trace[1829962680] 'compare' (duration: 901.811909ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:06:59.725428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:58.414028Z","time spent":"1.311375842s","remote":"127.0.0.1:33794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T10:06:59.72569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.309961864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-04-16T10:06:59.725721Z","caller":"traceutil/trace.go:171","msg":"trace[66953345] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:206; }","duration":"1.310020655s","start":"2026-04-16T10:06:58.415691Z","end":"2026-04-16T10:06:59.725711Z","steps":["trace[66953345] 'agreement among raft nodes before linearized reading' (duration: 1.309903034s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:59.725748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:58.415679Z","time spent":"1.310063706s","remote":"127.0.0.1:33892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3514,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-16T10:06:59.786749Z","caller":"traceutil/trace.go:171","msg":"trace[1578448502] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"1.370521589s","start":"2026-04-16T10:06:58.41618Z","end":"2026-04-16T10:06:59.786702Z","steps":["trace[1578448502] 'process raft request' (duration: 1.370359317s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:59.786848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.266094907s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:06:59.786927Z","caller":"traceutil/trace.go:171","msg":"trace[1936184082] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:209; }","duration":"1.266223498s","start":"2026-04-16T10:06:58.520684Z","end":"2026-04-16T10:06:59.786907Z","steps":["trace[1936184082] 'agreement among raft nodes before linearized reading' (duration: 1.266043735s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:59.786923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:58.416169Z","time spent":"1.370691371s","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T10:06:59.786908Z","caller":"traceutil/trace.go:171","msg":"trace[1168012772] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"1.369240752s","start":"2026-04-16T10:06:58.417631Z","end":"2026-04-16T10:06:59.786872Z","steps":["trace[1168012772] 'process raft request' (duration: 1.369019129s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:59.786958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:58.52066Z","time spent":"1.266291949s","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T10:06:59.787391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:58.417623Z","time spent":"1.369652738s","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T10:06:59.786988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.002216248s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:06:59.787595Z","caller":"traceutil/trace.go:171","msg":"trace[905648969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:209; }","duration":"1.002797805s","start":"2026-04-16T10:06:58.784741Z","end":"2026-04-16T10:06:59.787538Z","steps":["trace[905648969] 'agreement among raft nodes before linearized reading' (duration: 1.002233568s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:59.787683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:58.784723Z","time spent":"1.002931088s","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T10:06:59.787085Z","caller":"traceutil/trace.go:171","msg":"trace[1011117584] transaction","detail":"{read_only:false; response_revision:209; number_of_response:1; }","duration":"1.366824871s","start":"2026-04-16T10:06:58.420217Z","end":"2026-04-16T10:06:59.787042Z","steps":["trace[1011117584] 'process raft request' (duration: 1.366462866s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:06:59.788134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:06:58.420207Z","time spent":"1.36757767s","remote":"127.0.0.1:33892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3694,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:07:00.821913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.421754ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T10:07:00.822075Z","caller":"traceutil/trace.go:171","msg":"trace[712348848] transaction","detail":"{read_only:false; response_revision:274; number_of_response:1; }","duration":"189.837158ms","start":"2026-04-16T10:07:00.632203Z","end":"2026-04-16T10:07:00.82204Z","steps":["trace[712348848] 'process raft request' (duration: 51.192261ms)","trace[712348848] 'compare' (duration: 138.260812ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:00.822216Z","caller":"traceutil/trace.go:171","msg":"trace[1219695255] transaction","detail":"{read_only:false; response_revision:275; number_of_response:1; }","duration":"150.523662ms","start":"2026-04-16T10:07:00.671598Z","end":"2026-04-16T10:07:00.822121Z","steps":["trace[1219695255] 'process raft request' (duration: 150.419861ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:00.82221Z","caller":"traceutil/trace.go:171","msg":"trace[1348311028] linearizableReadLoop","detail":"{readStateIndex:280; appliedIndex:279; }","duration":"164.669868ms","start":"2026-04-16T10:07:00.657503Z","end":"2026-04-16T10:07:00.822173Z","steps":["trace[1348311028] 'read index received' (duration: 9.774768ms)","trace[1348311028] 'applied index is now lower than readState.Index' (duration: 154.88894ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:00.822489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.969901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-16T10:07:00.822577Z","caller":"traceutil/trace.go:171","msg":"trace[1159415875] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:275; }","duration":"165.112564ms","start":"2026-04-16T10:07:00.657451Z","end":"2026-04-16T10:07:00.822563Z","steps":["trace[1159415875] 'agreement among raft nodes before linearized reading' (duration: 164.81741ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:01.138973Z","caller":"traceutil/trace.go:171","msg":"trace[1020494308] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"120.74836ms","start":"2026-04-16T10:07:01.018191Z","end":"2026-04-16T10:07:01.138939Z","steps":["trace[1020494308] 'process raft request' (duration: 99.699895ms)","trace[1020494308] 'compare' (duration: 20.872923ms)"],"step_count":2} 2026/04/16 10:07:01 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" 2026/04/16 10:07:01 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-16T10:07:01.567588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.207129ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T10:07:01.567681Z","caller":"traceutil/trace.go:171","msg":"trace[770337602] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"240.509747ms","start":"2026-04-16T10:07:01.327154Z","end":"2026-04-16T10:07:01.567664Z","steps":["trace[770337602] 'process raft request' (duration: 105.151116ms)","trace[770337602] 'compare' (duration: 135.057858ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:01.59318Z","caller":"traceutil/trace.go:171","msg":"trace[1032824200] linearizableReadLoop","detail":"{readStateIndex:303; appliedIndex:301; }","duration":"263.867813ms","start":"2026-04-16T10:07:01.329292Z","end":"2026-04-16T10:07:01.59316Z","steps":["trace[1032824200] 'read index received' (duration: 103.024629ms)","trace[1032824200] 'applied index is now lower than readState.Index' (duration: 160.841994ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:01.593306Z","caller":"traceutil/trace.go:171","msg":"trace[2088443942] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"161.477093ms","start":"2026-04-16T10:07:01.43182Z","end":"2026-04-16T10:07:01.593297Z","steps":["trace[2088443942] 'process raft request' (duration: 161.28638ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:01.593316Z","caller":"traceutil/trace.go:171","msg":"trace[242687532] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"265.661727ms","start":"2026-04-16T10:07:01.327612Z","end":"2026-04-16T10:07:01.593274Z","steps":["trace[242687532] 'process raft request' (duration: 265.362883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:01.593584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.270978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-04-16T10:07:01.593766Z","caller":"traceutil/trace.go:171","msg":"trace[1282829304] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:297; }","duration":"264.480801ms","start":"2026-04-16T10:07:01.329269Z","end":"2026-04-16T10:07:01.593749Z","steps":["trace[1282829304] 'agreement among raft nodes before linearized reading' (duration: 264.201527ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:01.638634Z","caller":"traceutil/trace.go:171","msg":"trace[16446551] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"188.657519ms","start":"2026-04-16T10:07:01.449947Z","end":"2026-04-16T10:07:01.638604Z","steps":["trace[16446551] 'process raft request' (duration: 188.552477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:01.638767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.197969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-16T10:07:01.638759Z","caller":"traceutil/trace.go:171","msg":"trace[1999029840] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"188.198322ms","start":"2026-04-16T10:07:01.450532Z","end":"2026-04-16T10:07:01.63873Z","steps":["trace[1999029840] 'process raft request' (duration: 188.01545ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:01.638824Z","caller":"traceutil/trace.go:171","msg":"trace[740437970] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:297; }","duration":"281.30336ms","start":"2026-04-16T10:07:01.357511Z","end":"2026-04-16T10:07:01.638814Z","steps":["trace[740437970] 'agreement among raft nodes before linearized reading' (duration: 281.174259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:01.638873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.074654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-04-16T10:07:01.638942Z","caller":"traceutil/trace.go:171","msg":"trace[226193628] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:297; }","duration":"309.200946ms","start":"2026-04-16T10:07:01.329729Z","end":"2026-04-16T10:07:01.63893Z","steps":["trace[226193628] 'agreement among raft nodes before linearized reading' (duration: 308.987123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:01.638991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:01.329721Z","time spent":"309.261947ms","remote":"127.0.0.1:34126","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-16T10:07:01.638629Z","caller":"traceutil/trace.go:171","msg":"trace[85306370] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"188.77091ms","start":"2026-04-16T10:07:01.449807Z","end":"2026-04-16T10:07:01.638578Z","steps":["trace[85306370] 'process raft request' (duration: 188.663469ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:01.638634Z","caller":"traceutil/trace.go:171","msg":"trace[1454546386] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"188.487466ms","start":"2026-04-16T10:07:01.450125Z","end":"2026-04-16T10:07:01.638612Z","steps":["trace[1454546386] 'process raft request' (duration: 188.397684ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:01.638679Z","caller":"traceutil/trace.go:171","msg":"trace[1737993875] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"189.049863ms","start":"2026-04-16T10:07:01.449606Z","end":"2026-04-16T10:07:01.638656Z","steps":["trace[1737993875] 'process raft request' (duration: 188.750209ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:03.693123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.001041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-16T10:07:03.693198Z","caller":"traceutil/trace.go:171","msg":"trace[713809073] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:337; }","duration":"135.118493ms","start":"2026-04-16T10:07:03.558065Z","end":"2026-04-16T10:07:03.693183Z","steps":["trace[713809073] 'range keys from in-memory index tree' (duration: 134.91962ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:08.533109Z","caller":"traceutil/trace.go:171","msg":"trace[1164517293] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"221.161503ms","start":"2026-04-16T10:07:08.311924Z","end":"2026-04-16T10:07:08.533085Z","steps":["trace[1164517293] 'process raft request' (duration: 221.032342ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:10.184786Z","caller":"traceutil/trace.go:171","msg":"trace[136933250] linearizableReadLoop","detail":"{readStateIndex:459; appliedIndex:457; }","duration":"188.16743ms","start":"2026-04-16T10:07:09.996587Z","end":"2026-04-16T10:07:10.184755Z","steps":["trace[136933250] 'read index received' (duration: 60.230548ms)","trace[136933250] 'applied index is now lower than readState.Index' (duration: 127.935382ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:10.184939Z","caller":"traceutil/trace.go:171","msg":"trace[991050644] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"189.976764ms","start":"2026-04-16T10:07:09.994948Z","end":"2026-04-16T10:07:10.184925Z","steps":["trace[991050644] 'process raft request' (duration: 188.298753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:10.185037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.147815ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T10:07:10.185275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.660337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T10:07:10.185373Z","caller":"traceutil/trace.go:171","msg":"trace[2028891863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:441; }","duration":"188.800869ms","start":"2026-04-16T10:07:09.996551Z","end":"2026-04-16T10:07:10.185351Z","steps":["trace[2028891863] 'agreement among raft nodes before linearized reading' (duration: 188.563326ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:10.185409Z","caller":"traceutil/trace.go:171","msg":"trace[282389994] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:441; }","duration":"111.292717ms","start":"2026-04-16T10:07:10.073861Z","end":"2026-04-16T10:07:10.185154Z","steps":["trace[282389994] 'agreement among raft nodes before linearized reading' (duration: 111.105395ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:10.622617Z","caller":"traceutil/trace.go:171","msg":"trace[1347213597] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"199.410155ms","start":"2026-04-16T10:07:10.423163Z","end":"2026-04-16T10:07:10.622573Z","steps":["trace[1347213597] 'process raft request' (duration: 111.669062ms)","trace[1347213597] 'compare' (duration: 87.48619ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:14.119181Z","caller":"traceutil/trace.go:171","msg":"trace[1148298834] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"108.329302ms","start":"2026-04-16T10:07:14.010825Z","end":"2026-04-16T10:07:14.119154Z","steps":["trace[1148298834] 'process raft request' (duration: 108.065738ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:16.536434Z","caller":"traceutil/trace.go:171","msg":"trace[1273745341] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"273.330874ms","start":"2026-04-16T10:07:16.263033Z","end":"2026-04-16T10:07:16.536364Z","steps":["trace[1273745341] 'process raft request' (duration: 203.107334ms)","trace[1273745341] 'compare' (duration: 70.074298ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:17.216035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.024675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:17.216141Z","caller":"traceutil/trace.go:171","msg":"trace[886252735] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:459; }","duration":"542.178886ms","start":"2026-04-16T10:07:16.673937Z","end":"2026-04-16T10:07:17.216116Z","steps":["trace[886252735] 'range keys from in-memory index tree' (duration: 541.869183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:17.216186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:16.673914Z","time spent":"542.263118ms","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T10:07:17.216007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.844834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-16T10:07:17.216309Z","caller":"traceutil/trace.go:171","msg":"trace[124982169] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:459; }","duration":"241.145618ms","start":"2026-04-16T10:07:16.9751Z","end":"2026-04-16T10:07:17.216246Z","steps":["trace[124982169] 'range keys from in-memory index tree' (duration: 240.736013ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:17.824275Z","caller":"traceutil/trace.go:171","msg":"trace[1173118229] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"428.273133ms","start":"2026-04-16T10:07:17.395952Z","end":"2026-04-16T10:07:17.824225Z","steps":["trace[1173118229] 'process raft request' (duration: 375.268704ms)","trace[1173118229] 'compare' (duration: 52.763576ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:17.824476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:17.395933Z","time spent":"428.435746ms","remote":"127.0.0.1:33738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T10:07:24.786415Z","caller":"traceutil/trace.go:171","msg":"trace[357999035] linearizableReadLoop","detail":"{readStateIndex:532; appliedIndex:531; }","duration":"110.986249ms","start":"2026-04-16T10:07:24.675397Z","end":"2026-04-16T10:07:24.786383Z","steps":["trace[357999035] 'read index received' (duration: 110.757596ms)","trace[357999035] 'applied index is now lower than readState.Index' (duration: 227.523µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:24.786565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.141231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:24.786596Z","caller":"traceutil/trace.go:171","msg":"trace[1745280647] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:511; }","duration":"111.258713ms","start":"2026-04-16T10:07:24.675328Z","end":"2026-04-16T10:07:24.786587Z","steps":["trace[1745280647] 'agreement among raft nodes before linearized reading' (duration: 111.178682ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:24.786915Z","caller":"traceutil/trace.go:171","msg":"trace[1894329046] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"215.462947ms","start":"2026-04-16T10:07:24.571349Z","end":"2026-04-16T10:07:24.786812Z","steps":["trace[1894329046] 'process raft request' (duration: 214.848369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:26.080509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.057733838s","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-16T10:07:26.080604Z","caller":"traceutil/trace.go:171","msg":"trace[469830473] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:511; }","duration":"1.05787797s","start":"2026-04-16T10:07:25.022694Z","end":"2026-04-16T10:07:26.080572Z","steps":["trace[469830473] 'range keys from in-memory index tree' (duration: 1.057586126s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:26.080694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:25.022664Z","time spent":"1.058004991s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-04-16T10:07:26.10363Z","caller":"traceutil/trace.go:171","msg":"trace[372895033] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:532; }","duration":"427.604864ms","start":"2026-04-16T10:07:25.675979Z","end":"2026-04-16T10:07:26.103584Z","steps":["trace[372895033] 'read index received' (duration: 427.29344ms)","trace[372895033] 'applied index is now lower than readState.Index' (duration: 309.543µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:26.103717Z","caller":"traceutil/trace.go:171","msg":"trace[465868075] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"863.543665ms","start":"2026-04-16T10:07:25.240127Z","end":"2026-04-16T10:07:26.103671Z","steps":["trace[465868075] 'process raft request' (duration: 863.224741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:26.104016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.994028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T10:07:26.104054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:25.240083Z","time spent":"863.828138ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T10:07:26.104167Z","caller":"traceutil/trace.go:171","msg":"trace[1069695036] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:512; }","duration":"428.187221ms","start":"2026-04-16T10:07:25.675923Z","end":"2026-04-16T10:07:26.10411Z","steps":["trace[1069695036] 'agreement among raft nodes before linearized reading' (duration: 427.882007ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:26.104235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:25.675897Z","time spent":"428.329563ms","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T10:07:27.341506Z","caller":"traceutil/trace.go:171","msg":"trace[1870067742] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"175.126757ms","start":"2026-04-16T10:07:27.166354Z","end":"2026-04-16T10:07:27.341481Z","steps":["trace[1870067742] 'process raft request' (duration: 174.939454ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:31.513033Z","caller":"traceutil/trace.go:171","msg":"trace[224642415] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"166.405888ms","start":"2026-04-16T10:07:31.346605Z","end":"2026-04-16T10:07:31.513011Z","steps":["trace[224642415] 'process raft request' (duration: 115.03675ms)","trace[224642415] 'compare' (duration: 51.246606ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:32.670208Z","caller":"traceutil/trace.go:171","msg":"trace[778677733] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"379.058185ms","start":"2026-04-16T10:07:32.291127Z","end":"2026-04-16T10:07:32.670185Z","steps":["trace[778677733] 'process raft request' (duration: 378.917463ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:32.670225Z","caller":"traceutil/trace.go:171","msg":"trace[730164601] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:643; }","duration":"378.985794ms","start":"2026-04-16T10:07:32.291195Z","end":"2026-04-16T10:07:32.670181Z","steps":["trace[730164601] 'read index received' (duration: 378.968844ms)","trace[730164601] 'applied index is now lower than readState.Index' (duration: 14.29µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:32.670372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.291108Z","time spent":"379.184217ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:07:32.67056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.337139ms","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-16T10:07:32.670618Z","caller":"traceutil/trace.go:171","msg":"trace[269349793] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:617; }","duration":"379.449579ms","start":"2026-04-16T10:07:32.291153Z","end":"2026-04-16T10:07:32.670602Z","steps":["trace[269349793] 'agreement among raft nodes before linearized reading' (duration: 379.199136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:32.670672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.291133Z","time spent":"379.528481ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T10:07:32.880261Z","caller":"traceutil/trace.go:171","msg":"trace[480255917] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"466.375004ms","start":"2026-04-16T10:07:32.41382Z","end":"2026-04-16T10:07:32.880194Z","steps":["trace[480255917] 'process raft request' (duration: 461.643215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:32.880493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.413793Z","time spent":"466.590248ms","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:07:33.410879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.782521ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-16T10:07:33.411203Z","caller":"traceutil/trace.go:171","msg":"trace[720222693] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:643; }","duration":"740.814506ms","start":"2026-04-16T10:07:32.670311Z","end":"2026-04-16T10:07:33.411125Z","steps":["trace[720222693] 'read index received' (duration: 204.249843ms)","trace[720222693] 'applied index is now lower than readState.Index' (duration: 536.559613ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:33.411282Z","caller":"traceutil/trace.go:171","msg":"trace[1759609064] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"474.013596ms","start":"2026-04-16T10:07:32.93725Z","end":"2026-04-16T10:07:33.411264Z","steps":["trace[1759609064] 'process raft request' (duration: 473.943365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:33.411417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.937229Z","time spent":"474.117367ms","remote":"127.0.0.1:34096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T10:07:33.411758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.840179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:33.41185Z","caller":"traceutil/trace.go:171","msg":"trace[851715063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"737.960061ms","start":"2026-04-16T10:07:32.673866Z","end":"2026-04-16T10:07:33.411826Z","steps":["trace[851715063] 'agreement among raft nodes before linearized reading' (duration: 737.817629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:33.411991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105122576s","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-16T10:07:33.411977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.673822Z","time spent":"738.143463ms","remote":"127.0.0.1:33714","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T10:07:33.412084Z","caller":"traceutil/trace.go:171","msg":"trace[700843807] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"1.105246997s","start":"2026-04-16T10:07:32.30682Z","end":"2026-04-16T10:07:33.412067Z","steps":["trace[700843807] 'agreement among raft nodes before linearized reading' (duration: 1.104941403s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:33.412167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.306807Z","time spent":"1.105344788s","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T10:07:33.412005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.007521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T10:07:33.412249Z","caller":"traceutil/trace.go:171","msg":"trace[1297144189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"561.276445ms","start":"2026-04-16T10:07:32.850945Z","end":"2026-04-16T10:07:33.412221Z","steps":["trace[1297144189] 'agreement among raft nodes before linearized reading' (duration: 560.938321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:33.41234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.850921Z","time spent":"561.399926ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T10:07:33.412695Z","caller":"traceutil/trace.go:171","msg":"trace[88442093] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"735.651391ms","start":"2026-04-16T10:07:32.675963Z","end":"2026-04-16T10:07:33.411615Z","steps":["trace[88442093] 'process raft request' (duration: 735.071934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:33.412925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.675938Z","time spent":"736.856506ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:07:33.411651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.074871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n5kp7\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-16T10:07:33.413478Z","caller":"traceutil/trace.go:171","msg":"trace[1016956059] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n5kp7; range_end:; response_count:1; response_revision:620; }","duration":"966.971365ms","start":"2026-04-16T10:07:32.446487Z","end":"2026-04-16T10:07:33.413458Z","steps":["trace[1016956059] 'agreement among raft nodes before linearized reading' (duration: 964.840629ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:33.413571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:32.446465Z","time spent":"967.057466ms","remote":"127.0.0.1:33898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-n5kp7\" "} {"level":"warn","ts":"2026-04-16T10:07:35.011998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"911.841484ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T10:07:35.012483Z","caller":"traceutil/trace.go:171","msg":"trace[1746890179] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:649; }","duration":"1.338680585s","start":"2026-04-16T10:07:33.673793Z","end":"2026-04-16T10:07:35.012473Z","steps":["trace[1746890179] 'read index received' (duration: 426.425456ms)","trace[1746890179] 'applied index is now lower than readState.Index' (duration: 912.254239ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:35.012605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338799636s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.012632Z","caller":"traceutil/trace.go:171","msg":"trace[683646668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"1.338865447s","start":"2026-04-16T10:07:33.67376Z","end":"2026-04-16T10:07:35.012626Z","steps":["trace[683646668] 'agreement among raft nodes before linearized reading' (duration: 1.338806986s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.012655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:33.673745Z","time spent":"1.338905097s","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T10:07:35.012894Z","caller":"traceutil/trace.go:171","msg":"trace[1662337062] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"1.580481976s","start":"2026-04-16T10:07:33.431942Z","end":"2026-04-16T10:07:35.012424Z","steps":["trace[1662337062] 'process raft request' (duration: 668.176256ms)","trace[1662337062] 'compare' (duration: 911.565371ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:35.012991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:33.431927Z","time spent":"1.581017303s","remote":"127.0.0.1:33898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:07:35.013416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"809.394996ms","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-16T10:07:35.014013Z","caller":"traceutil/trace.go:171","msg":"trace[10596047] 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:624; }","duration":"810.038224ms","start":"2026-04-16T10:07:34.203955Z","end":"2026-04-16T10:07:35.013993Z","steps":["trace[10596047] 'agreement among raft nodes before linearized reading' (duration: 809.392406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.203935Z","time spent":"810.150735ms","remote":"127.0.0.1:52548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.014171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.312238ms","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":"warn","ts":"2026-04-16T10:07:35.014307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.39775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.014364Z","caller":"traceutil/trace.go:171","msg":"trace[246448910] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"270.530321ms","start":"2026-04-16T10:07:34.743819Z","end":"2026-04-16T10:07:35.01435Z","steps":["trace[246448910] 'agreement among raft nodes before linearized reading' (duration: 270.39096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.542921ms","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-16T10:07:35.0144Z","caller":"traceutil/trace.go:171","msg":"trace[1508807682] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"161.602652ms","start":"2026-04-16T10:07:34.852791Z","end":"2026-04-16T10:07:35.014393Z","steps":["trace[1508807682] 'agreement among raft nodes before linearized reading' (duration: 161.548561ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.073578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.014448Z","caller":"traceutil/trace.go:171","msg":"trace[2091929955] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"271.149309ms","start":"2026-04-16T10:07:34.743282Z","end":"2026-04-16T10:07:35.014431Z","steps":["trace[2091929955] 'agreement among raft nodes before linearized reading' (duration: 271.054538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.728907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.014626Z","caller":"traceutil/trace.go:171","msg":"trace[1875179626] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"182.783958ms","start":"2026-04-16T10:07:34.831834Z","end":"2026-04-16T10:07:35.014618Z","steps":["trace[1875179626] 'agreement among raft nodes before linearized reading' (duration: 182.741997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.861429ms","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-16T10:07:35.017033Z","caller":"traceutil/trace.go:171","msg":"trace[1582759324] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"185.820526ms","start":"2026-04-16T10:07:34.831197Z","end":"2026-04-16T10:07:35.017018Z","steps":["trace[1582759324] 'agreement among raft nodes before linearized reading' (duration: 182.864279ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:35.01432Z","caller":"traceutil/trace.go:171","msg":"trace[227269456] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"161.355718ms","start":"2026-04-16T10:07:34.852838Z","end":"2026-04-16T10:07:35.014194Z","steps":["trace[227269456] 'agreement among raft nodes before linearized reading' (duration: 161.318788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.151218ms","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-16T10:07:35.017313Z","caller":"traceutil/trace.go:171","msg":"trace[1306671809] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"226.825621ms","start":"2026-04-16T10:07:34.790477Z","end":"2026-04-16T10:07:35.017302Z","steps":["trace[1306671809] 'agreement among raft nodes before linearized reading' (duration: 224.144258ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:35.013746Z","caller":"traceutil/trace.go:171","msg":"trace[678641802] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.171495961s","start":"2026-04-16T10:07:33.842234Z","end":"2026-04-16T10:07:35.01373Z","steps":["trace[678641802] 'process raft request' (duration: 1.170376257s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.017562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:33.842215Z","time spent":"1.175275128s","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:07:35.014145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.897883ms","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-16T10:07:35.017877Z","caller":"traceutil/trace.go:171","msg":"trace[515277754] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:624; }","duration":"164.65236ms","start":"2026-04-16T10:07:34.85321Z","end":"2026-04-16T10:07:35.017863Z","steps":["trace[515277754] 'agreement among raft nodes before linearized reading' (duration: 160.921434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.454322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.018115Z","caller":"traceutil/trace.go:171","msg":"trace[924370923] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:624; }","duration":"274.923796ms","start":"2026-04-16T10:07:34.743182Z","end":"2026-04-16T10:07:35.018105Z","steps":["trace[924370923] 'agreement among raft nodes before linearized reading' (duration: 271.476793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.014708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.393721ms","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-16T10:07:35.018291Z","caller":"traceutil/trace.go:171","msg":"trace[563043213] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"227.976076ms","start":"2026-04-16T10:07:34.790305Z","end":"2026-04-16T10:07:35.018281Z","steps":["trace[563043213] 'agreement among raft nodes before linearized reading' (duration: 224.381071ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.015672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.655245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.018543Z","caller":"traceutil/trace.go:171","msg":"trace[1671167206] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"612.548351ms","start":"2026-04-16T10:07:34.405981Z","end":"2026-04-16T10:07:35.018529Z","steps":["trace[1671167206] 'agreement among raft nodes before linearized reading' (duration: 609.650974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.018593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.405971Z","time spent":"612.607011ms","remote":"127.0.0.1:52590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.015692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.020214ms","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-16T10:07:35.018842Z","caller":"traceutil/trace.go:171","msg":"trace[658346449] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"129.200035ms","start":"2026-04-16T10:07:34.889631Z","end":"2026-04-16T10:07:35.018831Z","steps":["trace[658346449] 'agreement among raft nodes before linearized reading' (duration: 125.987054ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.015715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.356235ms","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-16T10:07:35.019045Z","caller":"traceutil/trace.go:171","msg":"trace[849047080] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"291.697187ms","start":"2026-04-16T10:07:34.727338Z","end":"2026-04-16T10:07:35.019035Z","steps":["trace[849047080] 'agreement among raft nodes before linearized reading' (duration: 288.359675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.015803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.006628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.019247Z","caller":"traceutil/trace.go:171","msg":"trace[1133952078] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"317.461431ms","start":"2026-04-16T10:07:34.701776Z","end":"2026-04-16T10:07:35.019237Z","steps":["trace[1133952078] 'agreement among raft nodes before linearized reading' (duration: 313.955887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.019293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.701769Z","time spent":"317.510231ms","remote":"127.0.0.1:52618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-04-16T10:07:35.015837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.122932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.019492Z","caller":"traceutil/trace.go:171","msg":"trace[1429704614] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"318.788008ms","start":"2026-04-16T10:07:34.700694Z","end":"2026-04-16T10:07:35.019482Z","steps":["trace[1429704614] 'agreement among raft nodes before linearized reading' (duration: 315.124212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.019535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.700688Z","time spent":"318.835638ms","remote":"127.0.0.1:52618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.015869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.196682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.019707Z","caller":"traceutil/trace.go:171","msg":"trace[814934852] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:624; }","duration":"319.057671ms","start":"2026-04-16T10:07:34.700641Z","end":"2026-04-16T10:07:35.019698Z","steps":["trace[814934852] 'agreement among raft nodes before linearized reading' (duration: 315.213333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.019741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.700626Z","time spent":"319.103992ms","remote":"127.0.0.1:52618","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.015953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.123458ms","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-16T10:07:35.019864Z","caller":"traceutil/trace.go:171","msg":"trace[475549498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"345.047938ms","start":"2026-04-16T10:07:34.674808Z","end":"2026-04-16T10:07:35.019856Z","steps":["trace[475549498] 'agreement among raft nodes before linearized reading' (duration: 341.077799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.019892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.674799Z","time spent":"345.085619ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T10:07:35.015984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.890249ms","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-16T10:07:35.020083Z","caller":"traceutil/trace.go:171","msg":"trace[875923794] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"345.99503ms","start":"2026-04-16T10:07:34.674067Z","end":"2026-04-16T10:07:35.020062Z","steps":["trace[875923794] 'agreement among raft nodes before linearized reading' (duration: 341.900239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.020617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.674058Z","time spent":"346.525026ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-16T10:07:35.016014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.425375ms","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-16T10:07:35.021294Z","caller":"traceutil/trace.go:171","msg":"trace[1889138539] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"347.756172ms","start":"2026-04-16T10:07:34.673528Z","end":"2026-04-16T10:07:35.021284Z","steps":["trace[1889138539] 'agreement among raft nodes before linearized reading' (duration: 342.470796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.021406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.673495Z","time spent":"347.864123ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.016044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.613008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.021593Z","caller":"traceutil/trace.go:171","msg":"trace[1069892002] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"348.194657ms","start":"2026-04-16T10:07:34.673391Z","end":"2026-04-16T10:07:35.021586Z","steps":["trace[1069892002] 'agreement among raft nodes before linearized reading' (duration: 342.637947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.021702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.67337Z","time spent":"348.287709ms","remote":"127.0.0.1:52616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.016075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.614813ms","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-16T10:07:35.02212Z","caller":"traceutil/trace.go:171","msg":"trace[1355648434] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"459.658909ms","start":"2026-04-16T10:07:34.562454Z","end":"2026-04-16T10:07:35.022112Z","steps":["trace[1355648434] 'agreement among raft nodes before linearized reading' (duration: 453.605703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.022149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.562396Z","time spent":"459.74247ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.016106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.728664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.022372Z","caller":"traceutil/trace.go:171","msg":"trace[1005391728] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:624; }","duration":"460.014313ms","start":"2026-04-16T10:07:34.562351Z","end":"2026-04-16T10:07:35.022365Z","steps":["trace[1005391728] 'agreement among raft nodes before linearized reading' (duration: 453.738414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.022402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.562338Z","time spent":"460.055304ms","remote":"127.0.0.1:52600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.013677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.04867ms","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-16T10:07:35.022593Z","caller":"traceutil/trace.go:171","msg":"trace[1164516599] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:624; }","duration":"133.009483ms","start":"2026-04-16T10:07:34.889574Z","end":"2026-04-16T10:07:35.022584Z","steps":["trace[1164516599] 'agreement among raft nodes before linearized reading' (duration: 124.02122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.016137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.673875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.022833Z","caller":"traceutil/trace.go:171","msg":"trace[482114866] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"616.380889ms","start":"2026-04-16T10:07:34.406444Z","end":"2026-04-16T10:07:35.022825Z","steps":["trace[482114866] 'agreement among raft nodes before linearized reading' (duration: 609.676865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.022863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.406437Z","time spent":"616.416529ms","remote":"127.0.0.1:52590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-16T10:07:35.016169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.157341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.023038Z","caller":"traceutil/trace.go:171","msg":"trace[325877628] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"617.042547ms","start":"2026-04-16T10:07:34.405989Z","end":"2026-04-16T10:07:35.023031Z","steps":["trace[325877628] 'agreement among raft nodes before linearized reading' (duration: 610.164081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.023068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.405981Z","time spent":"617.078078ms","remote":"127.0.0.1:52590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.016165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.910245ms","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-16T10:07:35.023239Z","caller":"traceutil/trace.go:171","msg":"trace[550235673] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:624; }","duration":"192.020944ms","start":"2026-04-16T10:07:34.83121Z","end":"2026-04-16T10:07:35.023231Z","steps":["trace[550235673] 'agreement among raft nodes before linearized reading' (duration: 184.926965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.016228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.681813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.023486Z","caller":"traceutil/trace.go:171","msg":"trace[1504162978] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:624; }","duration":"689.937694ms","start":"2026-04-16T10:07:34.33354Z","end":"2026-04-16T10:07:35.023478Z","steps":["trace[1504162978] 'agreement among raft nodes before linearized reading' (duration: 682.672513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.023521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.333523Z","time spent":"689.987354ms","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.016259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.066207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.023675Z","caller":"traceutil/trace.go:171","msg":"trace[220619779] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"643.52898ms","start":"2026-04-16T10:07:34.380139Z","end":"2026-04-16T10:07:35.023668Z","steps":["trace[220619779] 'agreement among raft nodes before linearized reading' (duration: 636.104617ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.023699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.380116Z","time spent":"643.574811ms","remote":"127.0.0.1:52580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.01629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.215229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.023837Z","caller":"traceutil/trace.go:171","msg":"trace[215205277] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:624; }","duration":"643.787323ms","start":"2026-04-16T10:07:34.380043Z","end":"2026-04-16T10:07:35.023831Z","steps":["trace[215205277] 'agreement among raft nodes before linearized reading' (duration: 636.229309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.023864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.380032Z","time spent":"643.824634ms","remote":"127.0.0.1:52580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.01632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.424448ms","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-16T10:07:35.024039Z","caller":"traceutil/trace.go:171","msg":"trace[735644746] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"674.155165ms","start":"2026-04-16T10:07:34.349876Z","end":"2026-04-16T10:07:35.024031Z","steps":["trace[735644746] 'agreement among raft nodes before linearized reading' (duration: 666.428438ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.024067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.349869Z","time spent":"674.189995ms","remote":"127.0.0.1:52576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.016353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.699434ms","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-16T10:07:35.024315Z","caller":"traceutil/trace.go:171","msg":"trace[970614709] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"675.677744ms","start":"2026-04-16T10:07:34.348629Z","end":"2026-04-16T10:07:35.024307Z","steps":["trace[970614709] 'agreement among raft nodes before linearized reading' (duration: 667.704954ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.024346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.348622Z","time spent":"675.714855ms","remote":"127.0.0.1:52576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.016354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.288742ms","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-16T10:07:35.024538Z","caller":"traceutil/trace.go:171","msg":"trace[665445641] 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:624; }","duration":"820.505825ms","start":"2026-04-16T10:07:34.204022Z","end":"2026-04-16T10:07:35.024528Z","steps":["trace[665445641] 'agreement among raft nodes before linearized reading' (duration: 812.306062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.024593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.204001Z","time spent":"820.558276ms","remote":"127.0.0.1:52548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-16T10:07:35.016383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.868797ms","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-16T10:07:35.024733Z","caller":"traceutil/trace.go:171","msg":"trace[1595338277] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:624; }","duration":"676.234382ms","start":"2026-04-16T10:07:34.34849Z","end":"2026-04-16T10:07:35.024724Z","steps":["trace[1595338277] 'agreement among raft nodes before linearized reading' (duration: 667.877927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.024978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.348481Z","time spent":"676.459934ms","remote":"127.0.0.1:52576","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-04-16T10:07:35.016396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.877405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.025159Z","caller":"traceutil/trace.go:171","msg":"trace[1172826717] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:624; }","duration":"691.624326ms","start":"2026-04-16T10:07:34.333487Z","end":"2026-04-16T10:07:35.025111Z","steps":["trace[1172826717] 'agreement among raft nodes before linearized reading' (duration: 682.890306ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.025193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.33347Z","time spent":"691.713076ms","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 "} {"level":"warn","ts":"2026-04-16T10:07:35.016415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.035354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.025348Z","caller":"traceutil/trace.go:171","msg":"trace[1501548220] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:624; }","duration":"690.979607ms","start":"2026-04-16T10:07:34.334356Z","end":"2026-04-16T10:07:35.025336Z","steps":["trace[1501548220] 'agreement among raft nodes before linearized reading' (duration: 682.044255ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.025434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.334348Z","time spent":"691.020018ms","remote":"127.0.0.1:52562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T10:07:35.013454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.50454ms","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-16T10:07:35.025545Z","caller":"traceutil/trace.go:171","msg":"trace[1616972488] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"297.630282ms","start":"2026-04-16T10:07:34.727907Z","end":"2026-04-16T10:07:35.025538Z","steps":["trace[1616972488] 'agreement among raft nodes before linearized reading' (duration: 285.468959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.016429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.16696ms","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-16T10:07:35.025676Z","caller":"traceutil/trace.go:171","msg":"trace[2053178856] 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:624; }","duration":"821.432537ms","start":"2026-04-16T10:07:34.204235Z","end":"2026-04-16T10:07:35.025668Z","steps":["trace[2053178856] 'agreement among raft nodes before linearized reading' (duration: 812.17749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.025704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:34.204226Z","time spent":"821.469818ms","remote":"127.0.0.1:52548","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-16T10:07:35.01461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.223802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:35.025863Z","caller":"traceutil/trace.go:171","msg":"trace[1868079388] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:624; }","duration":"298.470113ms","start":"2026-04-16T10:07:34.727366Z","end":"2026-04-16T10:07:35.025836Z","steps":["trace[1868079388] 'agreement among raft nodes before linearized reading' (duration: 287.216421ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:35.664632Z","caller":"traceutil/trace.go:171","msg":"trace[1708733280] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"231.317136ms","start":"2026-04-16T10:07:35.433275Z","end":"2026-04-16T10:07:35.664592Z","steps":["trace[1708733280] 'read index received' (duration: 231.167154ms)","trace[1708733280] 'applied index is now lower than readState.Index' (duration: 147.232µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:35.664751Z","caller":"traceutil/trace.go:171","msg":"trace[2011494774] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"235.631989ms","start":"2026-04-16T10:07:35.429085Z","end":"2026-04-16T10:07:35.664717Z","steps":["trace[2011494774] 'process raft request' (duration: 235.276055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:35.664934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.636749ms","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-16T10:07:35.665017Z","caller":"traceutil/trace.go:171","msg":"trace[478170836] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:627; }","duration":"231.756621ms","start":"2026-04-16T10:07:35.433238Z","end":"2026-04-16T10:07:35.664994Z","steps":["trace[478170836] 'agreement among raft nodes before linearized reading' (duration: 231.521088ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:36.028614Z","caller":"traceutil/trace.go:171","msg":"trace[832380356] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"572.41296ms","start":"2026-04-16T10:07:35.456179Z","end":"2026-04-16T10:07:36.028592Z","steps":["trace[832380356] 'process raft request' (duration: 527.09994ms)","trace[832380356] 'compare' (duration: 44.939085ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:36.029202Z","caller":"traceutil/trace.go:171","msg":"trace[420881403] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:654; }","duration":"364.453208ms","start":"2026-04-16T10:07:35.664725Z","end":"2026-04-16T10:07:36.029179Z","steps":["trace[420881403] 'read index received' (duration: 318.714634ms)","trace[420881403] 'applied index is now lower than readState.Index' (duration: 45.735984ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:36.029223Z","caller":"traceutil/trace.go:171","msg":"trace[900716925] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"530.694096ms","start":"2026-04-16T10:07:35.498499Z","end":"2026-04-16T10:07:36.029194Z","steps":["trace[900716925] 'process raft request' (duration: 530.155039ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:36.029423Z","caller":"traceutil/trace.go:171","msg":"trace[1143187129] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"360.046283ms","start":"2026-04-16T10:07:35.669335Z","end":"2026-04-16T10:07:36.029381Z","steps":["trace[1143187129] 'process raft request' (duration: 359.797459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:36.029558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:35.669318Z","time spent":"360.172874ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:07:36.02962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.104553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-n5kp7\" ","response":"range_response_count:1 size:17145"} {"level":"info","ts":"2026-04-16T10:07:36.029705Z","caller":"traceutil/trace.go:171","msg":"trace[1511629425] range","detail":"{range_begin:/registry/pods/kube-system/cilium-n5kp7; range_end:; response_count:1; response_revision:630; }","duration":"575.277405ms","start":"2026-04-16T10:07:35.454407Z","end":"2026-04-16T10:07:36.029685Z","steps":["trace[1511629425] 'agreement among raft nodes before linearized reading' (duration: 574.87345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:36.029754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:35.454376Z","time spent":"575.369177ms","remote":"127.0.0.1:33898","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17168,"request content":"key:\"/registry/pods/kube-system/cilium-n5kp7\" "} {"level":"warn","ts":"2026-04-16T10:07:36.029763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.108271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-16T10:07:36.028722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:35.456165Z","time spent":"572.510881ms","remote":"127.0.0.1:33794","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":765,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T10:07:36.029939Z","caller":"traceutil/trace.go:171","msg":"trace[799248942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:630; }","duration":"566.266493ms","start":"2026-04-16T10:07:35.463594Z","end":"2026-04-16T10:07:36.029861Z","steps":["trace[799248942] 'agreement among raft nodes before linearized reading' (duration: 565.597164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:36.030003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:35.463549Z","time spent":"566.437614ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T10:07:36.029564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:35.498461Z","time spent":"530.953029ms","remote":"127.0.0.1:33816","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T10:07:37.928025Z","caller":"traceutil/trace.go:171","msg":"trace[57412811] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"252.504226ms","start":"2026-04-16T10:07:37.675181Z","end":"2026-04-16T10:07:37.927685Z","steps":["trace[57412811] 'process raft request' (duration: 224.337892ms)","trace[57412811] 'compare' (duration: 28.029812ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:37.928644Z","caller":"traceutil/trace.go:171","msg":"trace[1330104039] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"144.832656ms","start":"2026-04-16T10:07:37.783781Z","end":"2026-04-16T10:07:37.928614Z","steps":["trace[1330104039] 'process raft request' (duration: 144.729695ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:40.756254Z","caller":"traceutil/trace.go:171","msg":"trace[2037359869] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"251.863638ms","start":"2026-04-16T10:07:40.504367Z","end":"2026-04-16T10:07:40.75623Z","steps":["trace[2037359869] 'process raft request' (duration: 251.675265ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:41.056873Z","caller":"traceutil/trace.go:171","msg":"trace[1413191033] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"538.984888ms","start":"2026-04-16T10:07:40.517866Z","end":"2026-04-16T10:07:41.056851Z","steps":["trace[1413191033] 'process raft request' (duration: 533.332618ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:41.056896Z","caller":"traceutil/trace.go:171","msg":"trace[772379799] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:729; }","duration":"383.996702ms","start":"2026-04-16T10:07:40.67287Z","end":"2026-04-16T10:07:41.056867Z","steps":["trace[772379799] 'read index received' (duration: 83.243641ms)","trace[772379799] 'applied index is now lower than readState.Index' (duration: 300.7521ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:41.056986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:40.51781Z","time spent":"539.12108ms","remote":"127.0.0.1:33898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18497,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T10:07:41.056989Z","caller":"traceutil/trace.go:171","msg":"trace[1602530517] transaction","detail":"{read_only:false; response_revision:704; number_of_response:1; }","duration":"470.811156ms","start":"2026-04-16T10:07:40.586165Z","end":"2026-04-16T10:07:41.056977Z","steps":["trace[1602530517] 'process raft request' (duration: 470.612863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:41.057052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:40.586129Z","time spent":"470.887946ms","remote":"127.0.0.1:33760","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T10:07:41.057111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.239974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:41.057149Z","caller":"traceutil/trace.go:171","msg":"trace[840892068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:704; }","duration":"384.306445ms","start":"2026-04-16T10:07:40.672832Z","end":"2026-04-16T10:07:41.057139Z","steps":["trace[840892068] 'agreement among raft nodes before linearized reading' (duration: 384.226604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:41.057168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:40.672814Z","time spent":"384.349415ms","remote":"127.0.0.1:33724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T10:07:41.084133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.566675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-04-16T10:07:41.084227Z","caller":"traceutil/trace.go:171","msg":"trace[191218616] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:705; }","duration":"303.701727ms","start":"2026-04-16T10:07:40.780502Z","end":"2026-04-16T10:07:41.084203Z","steps":["trace[191218616] 'agreement among raft nodes before linearized reading' (duration: 303.448604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:41.084272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:40.780483Z","time spent":"303.777678ms","remote":"127.0.0.1:33760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-04-16T10:07:41.790582Z","caller":"traceutil/trace.go:171","msg":"trace[924126670] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:743; }","duration":"209.223344ms","start":"2026-04-16T10:07:41.581336Z","end":"2026-04-16T10:07:41.790559Z","steps":["trace[924126670] 'read index received' (duration: 36.431755ms)","trace[924126670] 'applied index is now lower than readState.Index' (duration: 172.790659ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:41.79059Z","caller":"traceutil/trace.go:171","msg":"trace[1503332952] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"236.639716ms","start":"2026-04-16T10:07:41.553918Z","end":"2026-04-16T10:07:41.790557Z","steps":["trace[1503332952] 'process raft request' (duration: 235.800236ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:41.790916Z","caller":"traceutil/trace.go:171","msg":"trace[98442581] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"109.721751ms","start":"2026-04-16T10:07:41.681172Z","end":"2026-04-16T10:07:41.790893Z","steps":["trace[98442581] 'process raft request' (duration: 109.346857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:41.790958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.956702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:07:41.791237Z","caller":"traceutil/trace.go:171","msg":"trace[54271025] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:717; }","duration":"117.284835ms","start":"2026-04-16T10:07:41.673931Z","end":"2026-04-16T10:07:41.791216Z","steps":["trace[54271025] 'agreement among raft nodes before linearized reading' (duration: 116.953621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:41.791719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.367768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-04-16T10:07:41.791943Z","caller":"traceutil/trace.go:171","msg":"trace[1876080365] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:717; }","duration":"210.614891ms","start":"2026-04-16T10:07:41.581292Z","end":"2026-04-16T10:07:41.791907Z","steps":["trace[1876080365] 'agreement among raft nodes before linearized reading' (duration: 209.349005ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:42.25766Z","caller":"traceutil/trace.go:171","msg":"trace[353233658] linearizableReadLoop","detail":"{readStateIndex:757; appliedIndex:756; }","duration":"108.073289ms","start":"2026-04-16T10:07:42.149564Z","end":"2026-04-16T10:07:42.257637Z","steps":["trace[353233658] 'read index received' (duration: 45.922463ms)","trace[353233658] 'applied index is now lower than readState.Index' (duration: 62.149716ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:07:42.257809Z","caller":"traceutil/trace.go:171","msg":"trace[196135264] transaction","detail":"{read_only:false; response_revision:729; number_of_response:1; }","duration":"192.845608ms","start":"2026-04-16T10:07:42.0649Z","end":"2026-04-16T10:07:42.257745Z","steps":["trace[196135264] 'process raft request' (duration: 130.649471ms)","trace[196135264] 'compare' (duration: 61.963064ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:42.257932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.365533ms","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-16T10:07:42.258141Z","caller":"traceutil/trace.go:171","msg":"trace[1696783567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:729; }","duration":"108.640216ms","start":"2026-04-16T10:07:42.149485Z","end":"2026-04-16T10:07:42.258125Z","steps":["trace[1696783567] 'agreement among raft nodes before linearized reading' (duration: 108.289212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:48.47356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.79481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T10:07:48.473647Z","caller":"traceutil/trace.go:171","msg":"trace[1465754893] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:769; }","duration":"132.897951ms","start":"2026-04-16T10:07:48.340729Z","end":"2026-04-16T10:07:48.473627Z","steps":["trace[1465754893] 'range keys from in-memory index tree' (duration: 132.598718ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:48.473559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.757012ms","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-16T10:07:48.47382Z","caller":"traceutil/trace.go:171","msg":"trace[490584234] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:769; }","duration":"192.093146ms","start":"2026-04-16T10:07:48.281687Z","end":"2026-04-16T10:07:48.47378Z","steps":["trace[490584234] 'range keys from in-memory index tree' (duration: 191.533339ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:52.319732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.170241222s","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-16T10:07:52.319904Z","caller":"traceutil/trace.go:171","msg":"trace[1860034133] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:789; }","duration":"1.170481105s","start":"2026-04-16T10:07:51.149392Z","end":"2026-04-16T10:07:52.319873Z","steps":["trace[1860034133] 'range keys from in-memory index tree' (duration: 1.169949578s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:52.320901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:51.149371Z","time spent":"1.171505268s","remote":"127.0.0.1:34010","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-16T10:07:52.321093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.298282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T10:07:52.321198Z","caller":"traceutil/trace.go:171","msg":"trace[1674727492] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:789; }","duration":"823.454494ms","start":"2026-04-16T10:07:51.497718Z","end":"2026-04-16T10:07:52.321173Z","steps":["trace[1674727492] 'range keys from in-memory index tree' (duration: 822.985708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:07:52.321154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.226615ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T10:07:52.321274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:51.497701Z","time spent":"823.557715ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-16T10:07:52.321276Z","caller":"traceutil/trace.go:171","msg":"trace[713079982] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:789; }","duration":"428.359536ms","start":"2026-04-16T10:07:51.892899Z","end":"2026-04-16T10:07:52.321259Z","steps":["trace[713079982] 'range keys from in-memory index tree' (duration: 428.211335ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:52.321534Z","caller":"traceutil/trace.go:171","msg":"trace[641489165] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:820; }","duration":"321.676445ms","start":"2026-04-16T10:07:51.999847Z","end":"2026-04-16T10:07:52.321523Z","steps":["trace[641489165] 'read index received' (duration: 263.078909ms)","trace[641489165] 'applied index is now lower than readState.Index' (duration: 58.596666ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:52.321705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.853107ms","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-16T10:07:52.321763Z","caller":"traceutil/trace.go:171","msg":"trace[2018863925] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:790; }","duration":"321.945007ms","start":"2026-04-16T10:07:51.999804Z","end":"2026-04-16T10:07:52.321749Z","steps":["trace[2018863925] 'agreement among raft nodes before linearized reading' (duration: 321.762995ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:07:52.321812Z","caller":"traceutil/trace.go:171","msg":"trace[1723346595] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"752.406424ms","start":"2026-04-16T10:07:51.569385Z","end":"2026-04-16T10:07:52.321791Z","steps":["trace[1723346595] 'process raft request' (duration: 693.605326ms)","trace[1723346595] 'compare' (duration: 56.51585ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:07:52.321857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:51.999789Z","time spent":"322.011978ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T10:07:52.321974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:07:51.569355Z","time spent":"752.542795ms","remote":"127.0.0.1:33972","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T10:08:23.166528Z","caller":"traceutil/trace.go:171","msg":"trace[990929127] linearizableReadLoop","detail":"{readStateIndex:1057; appliedIndex:1056; }","duration":"286.413455ms","start":"2026-04-16T10:08:22.880088Z","end":"2026-04-16T10:08:23.166502Z","steps":["trace[990929127] 'read index received' (duration: 286.236843ms)","trace[990929127] 'applied index is now lower than readState.Index' (duration: 175.212µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:23.166555Z","caller":"traceutil/trace.go:171","msg":"trace[2134053073] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"290.202582ms","start":"2026-04-16T10:08:22.876327Z","end":"2026-04-16T10:08:23.16653Z","steps":["trace[2134053073] 'process raft request' (duration: 290.02293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:23.166881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.770161ms","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-16T10:08:23.166947Z","caller":"traceutil/trace.go:171","msg":"trace[345031554] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1018; }","duration":"286.847742ms","start":"2026-04-16T10:08:22.880084Z","end":"2026-04-16T10:08:23.166931Z","steps":["trace[345031554] 'agreement among raft nodes before linearized reading' (duration: 286.521128ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:23.169805Z","caller":"traceutil/trace.go:171","msg":"trace[760069389] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"147.779058ms","start":"2026-04-16T10:08:23.022005Z","end":"2026-04-16T10:08:23.169784Z","steps":["trace[760069389] 'process raft request' (duration: 147.556866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:23.169926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.599534ms","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-16T10:08:23.169994Z","caller":"traceutil/trace.go:171","msg":"trace[1839506442] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1020; }","duration":"284.697815ms","start":"2026-04-16T10:08:22.885279Z","end":"2026-04-16T10:08:23.169977Z","steps":["trace[1839506442] 'agreement among raft nodes before linearized reading' (duration: 284.480472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:23.170165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.99601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T10:08:23.170218Z","caller":"traceutil/trace.go:171","msg":"trace[420479053] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1020; }","duration":"226.070991ms","start":"2026-04-16T10:08:22.944132Z","end":"2026-04-16T10:08:23.170203Z","steps":["trace[420479053] 'agreement among raft nodes before linearized reading' (duration: 225.95291ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:29.238279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.691771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21f2cdbb-4eeb-4951-bb40-fb30e3e8f5a1\" ","response":"range_response_count:1 size:3578"} {"level":"info","ts":"2026-04-16T10:08:29.238387Z","caller":"traceutil/trace.go:171","msg":"trace[1418772698] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-21f2cdbb-4eeb-4951-bb40-fb30e3e8f5a1; range_end:; response_count:1; response_revision:1056; }","duration":"296.801932ms","start":"2026-04-16T10:08:28.941522Z","end":"2026-04-16T10:08:29.238324Z","steps":["trace[1418772698] 'range keys from in-memory index tree' (duration: 296.555599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:29.238398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.931605ms","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-16T10:08:29.238459Z","caller":"traceutil/trace.go:171","msg":"trace[1595405238] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1056; }","duration":"349.031177ms","start":"2026-04-16T10:08:28.889411Z","end":"2026-04-16T10:08:29.238442Z","steps":["trace[1595405238] 'range keys from in-memory index tree' (duration: 348.795933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:29.238569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:08:28.889392Z","time spent":"349.163968ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T10:08:29.322578Z","caller":"traceutil/trace.go:171","msg":"trace[674389466] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"125.613215ms","start":"2026-04-16T10:08:29.196943Z","end":"2026-04-16T10:08:29.322556Z","steps":["trace[674389466] 'process raft request' (duration: 125.402502ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:29.322577Z","caller":"traceutil/trace.go:171","msg":"trace[1671595033] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1098; }","duration":"124.960627ms","start":"2026-04-16T10:08:29.197588Z","end":"2026-04-16T10:08:29.322549Z","steps":["trace[1671595033] 'read index received' (duration: 124.909196ms)","trace[1671595033] 'applied index is now lower than readState.Index' (duration: 49.551µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:08:29.322778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.169709ms","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-16T10:08:29.322834Z","caller":"traceutil/trace.go:171","msg":"trace[1122273308] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1057; }","duration":"125.269301ms","start":"2026-04-16T10:08:29.197547Z","end":"2026-04-16T10:08:29.322817Z","steps":["trace[1122273308] 'agreement among raft nodes before linearized reading' (duration: 125.083609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:29.54629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.186062ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T10:08:29.546655Z","caller":"traceutil/trace.go:171","msg":"trace[1939854830] transaction","detail":"{read_only:false; response_revision:1058; number_of_response:1; }","duration":"303.9585ms","start":"2026-04-16T10:08:29.242606Z","end":"2026-04-16T10:08:29.546564Z","steps":["trace[1939854830] 'process raft request' (duration: 116.322392ms)","trace[1939854830] 'compare' (duration: 186.769457ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:29.546728Z","caller":"traceutil/trace.go:171","msg":"trace[2074284177] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"219.815468ms","start":"2026-04-16T10:08:29.326882Z","end":"2026-04-16T10:08:29.546698Z","steps":["trace[2074284177] 'process raft request' (duration: 219.599826ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:29.546967Z","caller":"traceutil/trace.go:171","msg":"trace[1155385681] linearizableReadLoop","detail":"{readStateIndex:1099; appliedIndex:1098; }","duration":"224.228361ms","start":"2026-04-16T10:08:29.322721Z","end":"2026-04-16T10:08:29.546949Z","steps":["trace[1155385681] 'read index received' (duration: 36.21936ms)","trace[1155385681] 'applied index is now lower than readState.Index' (duration: 188.007151ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:08:29.547187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.735061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-04-16T10:08:29.547214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.901854ms","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-16T10:08:29.547237Z","caller":"traceutil/trace.go:171","msg":"trace[1470827247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1059; }","duration":"324.820643ms","start":"2026-04-16T10:08:29.222402Z","end":"2026-04-16T10:08:29.547222Z","steps":["trace[1470827247] 'agreement among raft nodes before linearized reading' (duration: 324.596ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:29.547263Z","caller":"traceutil/trace.go:171","msg":"trace[1718762019] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1059; }","duration":"348.970676ms","start":"2026-04-16T10:08:29.198277Z","end":"2026-04-16T10:08:29.547247Z","steps":["trace[1718762019] 'agreement among raft nodes before linearized reading' (duration: 348.725473ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:29.547273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:08:29.22236Z","time spent":"324.904913ms","remote":"127.0.0.1:34010","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-16T10:08:29.547311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:08:29.198267Z","time spent":"349.032617ms","remote":"127.0.0.1:34010","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-16T10:08:29.547511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:08:29.242583Z","time spent":"304.160122ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T10:08:29.547703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.555694ms","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-16T10:08:29.547788Z","caller":"traceutil/trace.go:171","msg":"trace[1286953684] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1059; }","duration":"336.99591ms","start":"2026-04-16T10:08:29.210774Z","end":"2026-04-16T10:08:29.54777Z","steps":["trace[1286953684] 'agreement among raft nodes before linearized reading' (duration: 336.466394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:29.547833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T10:08:29.210762Z","time spent":"337.058361ms","remote":"127.0.0.1:34010","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T10:08:29.695977Z","caller":"traceutil/trace.go:171","msg":"trace[1430407191] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"143.846006ms","start":"2026-04-16T10:08:29.552103Z","end":"2026-04-16T10:08:29.695949Z","steps":["trace[1430407191] 'process raft request' (duration: 143.784605ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:29.696038Z","caller":"traceutil/trace.go:171","msg":"trace[263866688] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"143.984497ms","start":"2026-04-16T10:08:29.552022Z","end":"2026-04-16T10:08:29.696007Z","steps":["trace[263866688] 'process raft request' (duration: 102.831158ms)","trace[263866688] 'compare' (duration: 40.842596ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:29.823857Z","caller":"traceutil/trace.go:171","msg":"trace[1293556061] transaction","detail":"{read_only:false; response_revision:1063; number_of_response:1; }","duration":"104.833573ms","start":"2026-04-16T10:08:29.718988Z","end":"2026-04-16T10:08:29.823821Z","steps":["trace[1293556061] 'process raft request' (duration: 85.295776ms)","trace[1293556061] 'compare' (duration: 19.285644ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:41.570593Z","caller":"traceutil/trace.go:171","msg":"trace[5159849] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"106.439505ms","start":"2026-04-16T10:08:41.464124Z","end":"2026-04-16T10:08:41.570564Z","steps":["trace[5159849] 'process raft request' (duration: 106.276013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:41.705921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.716898ms","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-16T10:08:41.706034Z","caller":"traceutil/trace.go:171","msg":"trace[1419152606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1118; }","duration":"110.87405ms","start":"2026-04-16T10:08:41.595131Z","end":"2026-04-16T10:08:41.706005Z","steps":["trace[1419152606] 'range keys from in-memory index tree' (duration: 110.486135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:41.706191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.626012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T10:08:41.706301Z","caller":"traceutil/trace.go:171","msg":"trace[1330411430] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1118; }","duration":"108.768904ms","start":"2026-04-16T10:08:41.597508Z","end":"2026-04-16T10:08:41.706277Z","steps":["trace[1330411430] 'range keys from in-memory index tree' (duration: 108.467321ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:42.849726Z","caller":"traceutil/trace.go:171","msg":"trace[1449795717] linearizableReadLoop","detail":"{readStateIndex:1169; appliedIndex:1168; }","duration":"175.808753ms","start":"2026-04-16T10:08:42.67389Z","end":"2026-04-16T10:08:42.849699Z","steps":["trace[1449795717] 'read index received' (duration: 175.657691ms)","trace[1449795717] 'applied index is now lower than readState.Index' (duration: 150.152µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:42.84978Z","caller":"traceutil/trace.go:171","msg":"trace[1643096644] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"252.312977ms","start":"2026-04-16T10:08:42.597445Z","end":"2026-04-16T10:08:42.849758Z","steps":["trace[1643096644] 'process raft request' (duration: 252.114585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:42.849885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.986596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T10:08:42.849933Z","caller":"traceutil/trace.go:171","msg":"trace[1883694919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1124; }","duration":"176.113076ms","start":"2026-04-16T10:08:42.673806Z","end":"2026-04-16T10:08:42.849919Z","steps":["trace[1883694919] 'agreement among raft nodes before linearized reading' (duration: 175.998425ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:43.793742Z","caller":"traceutil/trace.go:171","msg":"trace[448062506] linearizableReadLoop","detail":"{readStateIndex:1171; appliedIndex:1170; }","duration":"146.041234ms","start":"2026-04-16T10:08:43.647678Z","end":"2026-04-16T10:08:43.793719Z","steps":["trace[448062506] 'read index received' (duration: 145.928002ms)","trace[448062506] 'applied index is now lower than readState.Index' (duration: 112.132µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:43.793791Z","caller":"traceutil/trace.go:171","msg":"trace[1480394369] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"217.585677ms","start":"2026-04-16T10:08:43.576178Z","end":"2026-04-16T10:08:43.793764Z","steps":["trace[1480394369] 'process raft request' (duration: 217.393935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:43.831096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.336744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T10:08:43.831251Z","caller":"traceutil/trace.go:171","msg":"trace[1855854953] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1126; }","duration":"183.566736ms","start":"2026-04-16T10:08:43.647631Z","end":"2026-04-16T10:08:43.831197Z","steps":["trace[1855854953] 'agreement among raft nodes before linearized reading' (duration: 146.224125ms)","trace[1855854953] 'count revisions from in-memory index tree' (duration: 37.099497ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:43.964037Z","caller":"traceutil/trace.go:171","msg":"trace[1301870022] linearizableReadLoop","detail":"{readStateIndex:1172; appliedIndex:1171; }","duration":"170.188245ms","start":"2026-04-16T10:08:43.79382Z","end":"2026-04-16T10:08:43.964008Z","steps":["trace[1301870022] 'read index received' (duration: 169.898891ms)","trace[1301870022] 'applied index is now lower than readState.Index' (duration: 288.234µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T10:08:43.964297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.808923ms","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-16T10:08:43.964394Z","caller":"traceutil/trace.go:171","msg":"trace[726846877] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1127; }","duration":"223.940404ms","start":"2026-04-16T10:08:43.740433Z","end":"2026-04-16T10:08:43.964374Z","steps":["trace[726846877] 'agreement among raft nodes before linearized reading' (duration: 223.63656ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:43.964379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.698895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-16T10:08:43.964425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.222157ms","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-16T10:08:43.964527Z","caller":"traceutil/trace.go:171","msg":"trace[384901226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1127; }","duration":"243.380219ms","start":"2026-04-16T10:08:43.721094Z","end":"2026-04-16T10:08:43.964474Z","steps":["trace[384901226] 'agreement among raft nodes before linearized reading' (duration: 243.014605ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:43.964586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.784851ms","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-16T10:08:43.964622Z","caller":"traceutil/trace.go:171","msg":"trace[1963581532] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1127; }","duration":"174.842871ms","start":"2026-04-16T10:08:43.789768Z","end":"2026-04-16T10:08:43.964611Z","steps":["trace[1963581532] 'agreement among raft nodes before linearized reading' (duration: 174.75688ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:43.964741Z","caller":"traceutil/trace.go:171","msg":"trace[2022619387] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"174.79444ms","start":"2026-04-16T10:08:43.789773Z","end":"2026-04-16T10:08:43.964568Z","steps":["trace[2022619387] 'process raft request' (duration: 174.039891ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:43.964989Z","caller":"traceutil/trace.go:171","msg":"trace[1994305409] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1127; }","duration":"239.828316ms","start":"2026-04-16T10:08:43.724618Z","end":"2026-04-16T10:08:43.964446Z","steps":["trace[1994305409] 'agreement among raft nodes before linearized reading' (duration: 239.660974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:43.96552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.56311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T10:08:43.965566Z","caller":"traceutil/trace.go:171","msg":"trace[612895551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1127; }","duration":"223.64816ms","start":"2026-04-16T10:08:43.741905Z","end":"2026-04-16T10:08:43.965553Z","steps":["trace[612895551] 'agreement among raft nodes before linearized reading' (duration: 222.207293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:43.966598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.944291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T10:08:43.972364Z","caller":"traceutil/trace.go:171","msg":"trace[1645603166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1127; }","duration":"199.744392ms","start":"2026-04-16T10:08:43.772598Z","end":"2026-04-16T10:08:43.972342Z","steps":["trace[1645603166] 'agreement among raft nodes before linearized reading' (duration: 191.442872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:54.228915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.30916ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T10:08:54.229013Z","caller":"traceutil/trace.go:171","msg":"trace[575879554] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"175.896086ms","start":"2026-04-16T10:08:54.053102Z","end":"2026-04-16T10:08:54.228998Z","steps":["trace[575879554] 'process raft request' (duration: 29.433084ms)","trace[575879554] 'compare' (duration: 146.173229ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:54.299602Z","caller":"traceutil/trace.go:171","msg":"trace[1745012233] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"246.243243ms","start":"2026-04-16T10:08:54.053337Z","end":"2026-04-16T10:08:54.29958Z","steps":["trace[1745012233] 'process raft request' (duration: 246.061121ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:54.299821Z","caller":"traceutil/trace.go:171","msg":"trace[1186365654] linearizableReadLoop","detail":"{readStateIndex:1216; appliedIndex:1212; }","duration":"227.839072ms","start":"2026-04-16T10:08:54.071965Z","end":"2026-04-16T10:08:54.299804Z","steps":["trace[1186365654] 'read index received' (duration: 10.583977ms)","trace[1186365654] 'applied index is now lower than readState.Index' (duration: 217.253995ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T10:08:54.299933Z","caller":"traceutil/trace.go:171","msg":"trace[488433205] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"246.124232ms","start":"2026-04-16T10:08:54.053791Z","end":"2026-04-16T10:08:54.299915Z","steps":["trace[488433205] 'process raft request' (duration: 245.750288ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:54.300017Z","caller":"traceutil/trace.go:171","msg":"trace[1353983591] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"245.660226ms","start":"2026-04-16T10:08:54.054283Z","end":"2026-04-16T10:08:54.299943Z","steps":["trace[1353983591] 'process raft request' (duration: 245.451514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:54.300278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.226856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T10:08:54.300369Z","caller":"traceutil/trace.go:171","msg":"trace[1015169800] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-proxier; range_end:; response_count:1; response_revision:1168; }","duration":"228.428929ms","start":"2026-04-16T10:08:54.071919Z","end":"2026-04-16T10:08:54.300348Z","steps":["trace[1015169800] 'agreement among raft nodes before linearized reading' (duration: 228.096085ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T10:08:54.316539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.469254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:disruption-controller\" ","response":"range_response_count:1 size:972"} {"level":"info","ts":"2026-04-16T10:08:54.316544Z","caller":"traceutil/trace.go:171","msg":"trace[1014728968] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"141.026118ms","start":"2026-04-16T10:08:54.175482Z","end":"2026-04-16T10:08:54.316508Z","steps":["trace[1014728968] 'process raft request' (duration: 140.899106ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T10:08:54.316599Z","caller":"traceutil/trace.go:171","msg":"trace[949020842] range","detail":"{range_begin:/registry/clusterroles/system:controller:disruption-controller; range_end:; response_count:1; response_revision:1169; }","duration":"191.566816ms","start":"2026-04-16T10:08:54.125015Z","end":"2026-04-16T10:08:54.316582Z","steps":["trace[949020842] 'agreement among raft nodes before linearized reading' (duration: 191.456244ms)"],"step_count":1}