{"level":"warn","ts":"2026-05-08T21:12:29.865136Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T21:12:29.865435Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-05-08T21:12:29.865499Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T21:12:29.865512Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-05-08T21:12:29.865529Z","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-05-08T21:12:29.866176Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-05-08T21:12:29.86627Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-05-08T21:12:29.873693Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.92827ms"} {"level":"info","ts":"2026-05-08T21:12:29.891079Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-05-08T21:12:29.891175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T21:12:29.891197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-05-08T21:12:29.891213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T21:12:29.891229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-05-08T21:12:29.89127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-05-08T21:12:29.90016Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T21:12:29.904591Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T21:12:29.906106Z","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-05-08T21:12:29.90821Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T21:12:29.909317Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T21:12:29.909583Z","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-05-08T21:12:29.909679Z","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-05-08T21:12:29.910679Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-05-08T21:12:29.909742Z","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-05-08T21:12:29.911255Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-05-08T21:12:29.913257Z","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-05-08T21:12:29.913321Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-08T21:12:29.913333Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-05-08T21:12:29.914192Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T21:12:29.91422Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T21:12:30.391938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T21:12:30.392021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T21:12:30.392047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-05-08T21:12:30.392065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-05-08T21:12:30.392076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-08T21:12:30.392091Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-05-08T21:12:30.392108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-05-08T21:12:30.431329Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:12:30.433291Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T21:12:30.433482Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T21:12:30.437361Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T21:12:30.437768Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T21:12:30.438103Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T21:12:30.438143Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T21:12:30.438711Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:12:30.4388Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:12:30.439Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T21:12:30.441464Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-05-08T21:12:42.246258Z","caller":"traceutil/trace.go:171","msg":"trace[1035474748] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"195.816077ms","start":"2026-05-08T21:12:42.050422Z","end":"2026-05-08T21:12:42.246238Z","steps":["trace[1035474748] 'process raft request' (duration: 195.705285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:12:54.131422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.392232ms","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-05-08T21:12:54.131524Z","caller":"traceutil/trace.go:171","msg":"trace[451173644] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:464; }","duration":"259.563566ms","start":"2026-05-08T21:12:53.871942Z","end":"2026-05-08T21:12:54.131506Z","steps":["trace[451173644] 'range keys from in-memory index tree' (duration: 259.289199ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:54.932296Z","caller":"traceutil/trace.go:171","msg":"trace[103446622] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"230.330688ms","start":"2026-05-08T21:12:54.701935Z","end":"2026-05-08T21:12:54.932266Z","steps":["trace[103446622] 'process raft request' (duration: 230.176684ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:59.283231Z","caller":"traceutil/trace.go:171","msg":"trace[461957473] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"235.957091ms","start":"2026-05-08T21:12:59.047242Z","end":"2026-05-08T21:12:59.283199Z","steps":["trace[461957473] 'process raft request' (duration: 155.17278ms)","trace[461957473] 'compare' (duration: 80.644097ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:12:59.29794Z","caller":"traceutil/trace.go:171","msg":"trace[26965949] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"242.061404ms","start":"2026-05-08T21:12:59.055856Z","end":"2026-05-08T21:12:59.297918Z","steps":["trace[26965949] 'process raft request' (duration: 241.666525ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:59.297982Z","caller":"traceutil/trace.go:171","msg":"trace[731071064] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"233.551394ms","start":"2026-05-08T21:12:59.064407Z","end":"2026-05-08T21:12:59.297958Z","steps":["trace[731071064] 'process raft request' (duration: 233.347129ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:59.568729Z","caller":"traceutil/trace.go:171","msg":"trace[515544898] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"101.859646ms","start":"2026-05-08T21:12:59.466815Z","end":"2026-05-08T21:12:59.568675Z","steps":["trace[515544898] 'process raft request' (duration: 83.392141ms)","trace[515544898] 'compare' (duration: 18.167388ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:12:59.80402Z","caller":"traceutil/trace.go:171","msg":"trace[1109527589] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"216.083183ms","start":"2026-05-08T21:12:59.587911Z","end":"2026-05-08T21:12:59.803994Z","steps":["trace[1109527589] 'process raft request' (duration: 192.574ms)","trace[1109527589] 'compare' (duration: 23.37454ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:12:59.815979Z","caller":"traceutil/trace.go:171","msg":"trace[1904272841] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"219.232147ms","start":"2026-05-08T21:12:59.596721Z","end":"2026-05-08T21:12:59.815953Z","steps":["trace[1904272841] 'process raft request' (duration: 218.753315ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:12:59.820435Z","caller":"traceutil/trace.go:171","msg":"trace[581039005] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"171.951185ms","start":"2026-05-08T21:12:59.648468Z","end":"2026-05-08T21:12:59.820419Z","steps":["trace[581039005] 'process raft request' (duration: 167.246724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:00.784364Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269076919,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T21:13:01.019416Z","caller":"traceutil/trace.go:171","msg":"trace[315993827] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"750.557926ms","start":"2026-05-08T21:13:00.268825Z","end":"2026-05-08T21:13:01.019383Z","steps":["trace[315993827] 'process raft request' (duration: 687.675357ms)","trace[315993827] 'compare' (duration: 62.552081ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:13:01.019899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:00.268812Z","time spent":"750.684328ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T21:13:01.598788Z","caller":"traceutil/trace.go:171","msg":"trace[1237288541] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.161349048s","start":"2026-05-08T21:13:00.43741Z","end":"2026-05-08T21:13:01.598759Z","steps":["trace[1237288541] 'process raft request' (duration: 1.13292709s)","trace[1237288541] 'compare' (duration: 28.021409ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:13:01.598909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:00.437366Z","time spent":"1.161486952s","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T21:13:01.59956Z","caller":"traceutil/trace.go:171","msg":"trace[542209689] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"563.27542ms","start":"2026-05-08T21:13:01.036271Z","end":"2026-05-08T21:13:01.599547Z","steps":["trace[542209689] 'process raft request' (duration: 562.393899ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:01.59958Z","caller":"traceutil/trace.go:171","msg":"trace[1267324133] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"762.265711ms","start":"2026-05-08T21:13:00.837251Z","end":"2026-05-08T21:13:01.599517Z","steps":["trace[1267324133] 'process raft request' (duration: 761.37936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:01.599738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335818402s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:13:01.599767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:00.837226Z","time spent":"762.457185ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T21:13:01.599786Z","caller":"traceutil/trace.go:171","msg":"trace[1815884116] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"1.335903284s","start":"2026-05-08T21:13:00.263871Z","end":"2026-05-08T21:13:01.599775Z","steps":["trace[1815884116] 'agreement among raft nodes before linearized reading' (duration: 1.335776881s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:01.599821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:00.26386Z","time spent":"1.335954235s","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T21:13:01.599845Z","caller":"traceutil/trace.go:171","msg":"trace[125232718] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"963.028353ms","start":"2026-05-08T21:13:00.636804Z","end":"2026-05-08T21:13:01.599832Z","steps":["trace[125232718] 'process raft request' (duration: 961.760603ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:01.599592Z","caller":"traceutil/trace.go:171","msg":"trace[655897560] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:612; }","duration":"1.318332901s","start":"2026-05-08T21:13:00.281213Z","end":"2026-05-08T21:13:01.599546Z","steps":["trace[655897560] 'read index received' (duration: 675.152261ms)","trace[655897560] 'applied index is now lower than readState.Index' (duration: 643.17675ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:13:01.599628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:01.036239Z","time spent":"563.359831ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T21:13:01.600191Z","caller":"traceutil/trace.go:171","msg":"trace[1773530343] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"483.524744ms","start":"2026-05-08T21:13:01.116651Z","end":"2026-05-08T21:13:01.600176Z","steps":["trace[1773530343] 'process raft request' (duration: 482.045509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:01.600276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:01.116626Z","time spent":"483.601726ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T21:13:01.59992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:00.636765Z","time spent":"963.130075ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T21:13:01.604127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.443823ms","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-05-08T21:13:01.604245Z","caller":"traceutil/trace.go:171","msg":"trace[1396186326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"560.625798ms","start":"2026-05-08T21:13:01.043589Z","end":"2026-05-08T21:13:01.604215Z","steps":["trace[1396186326] 'agreement among raft nodes before linearized reading' (duration: 560.242549ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:01.604345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:01.043565Z","time spent":"560.74596ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-08T21:13:01.604341Z","caller":"traceutil/trace.go:171","msg":"trace[1882027261] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"164.610572ms","start":"2026-05-08T21:13:01.439677Z","end":"2026-05-08T21:13:01.604288Z","steps":["trace[1882027261] 'process raft request' (duration: 163.823644ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:01.60437Z","caller":"traceutil/trace.go:171","msg":"trace[1736189373] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"363.003519ms","start":"2026-05-08T21:13:01.241189Z","end":"2026-05-08T21:13:01.604192Z","steps":["trace[1736189373] 'process raft request' (duration: 362.270362ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:01.604438Z","caller":"traceutil/trace.go:171","msg":"trace[1324022652] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"402.289133ms","start":"2026-05-08T21:13:01.201994Z","end":"2026-05-08T21:13:01.604283Z","steps":["trace[1324022652] 'process raft request' (duration: 400.384548ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:01.604843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.977496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T21:13:01.605154Z","caller":"traceutil/trace.go:171","msg":"trace[12796398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"618.310864ms","start":"2026-05-08T21:13:00.986824Z","end":"2026-05-08T21:13:01.605135Z","steps":["trace[12796398] 'agreement among raft nodes before linearized reading' (duration: 617.942156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:01.605219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:00.986803Z","time spent":"618.394987ms","remote":"127.0.0.1:40134","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-05-08T21:13:01.604881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:01.241161Z","time spent":"363.312966ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T21:13:01.605367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:01.201968Z","time spent":"403.066671ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:13:01.837207Z","caller":"traceutil/trace.go:171","msg":"trace[759906137] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"144.765106ms","start":"2026-05-08T21:13:01.692423Z","end":"2026-05-08T21:13:01.837188Z","steps":["trace[759906137] 'process raft request' (duration: 142.79818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:02.607811Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269076976,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T21:13:02.901881Z","caller":"traceutil/trace.go:171","msg":"trace[1225772109] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"806.85667ms","start":"2026-05-08T21:13:02.094999Z","end":"2026-05-08T21:13:02.901856Z","steps":["trace[1225772109] 'process raft request' (duration: 806.718097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:02.902019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:02.094985Z","time spent":"806.964382ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:13:02.912719Z","caller":"traceutil/trace.go:171","msg":"trace[1944017376] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"800.002668ms","start":"2026-05-08T21:13:02.112696Z","end":"2026-05-08T21:13:02.912699Z","steps":["trace[1944017376] 'process raft request' (duration: 799.527547ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:02.912816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:02.112658Z","time spent":"800.106171ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:13:02.912916Z","caller":"traceutil/trace.go:171","msg":"trace[1664241823] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:648; }","duration":"805.364025ms","start":"2026-05-08T21:13:02.107371Z","end":"2026-05-08T21:13:02.912735Z","steps":["trace[1664241823] 'read index received' (duration: 792.83368ms)","trace[1664241823] 'applied index is now lower than readState.Index' (duration: 12.527055ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:13:02.913184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"730.517384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-08T21:13:02.913225Z","caller":"traceutil/trace.go:171","msg":"trace[145920874] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"730.608246ms","start":"2026-05-08T21:13:02.182604Z","end":"2026-05-08T21:13:02.913212Z","steps":["trace[145920874] 'agreement among raft nodes before linearized reading' (duration: 730.459923ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:02.913218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.816235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"warn","ts":"2026-05-08T21:13:02.913264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:02.182586Z","time spent":"730.669927ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T21:13:02.913293Z","caller":"traceutil/trace.go:171","msg":"trace[787981426] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:631; }","duration":"805.928358ms","start":"2026-05-08T21:13:02.107347Z","end":"2026-05-08T21:13:02.913276Z","steps":["trace[787981426] 'agreement among raft nodes before linearized reading' (duration: 805.59273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:02.913303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.51614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-05-08T21:13:02.91334Z","caller":"traceutil/trace.go:171","msg":"trace[1319312764] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:631; }","duration":"479.585512ms","start":"2026-05-08T21:13:02.433744Z","end":"2026-05-08T21:13:02.91333Z","steps":["trace[1319312764] 'agreement among raft nodes before linearized reading' (duration: 479.462709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:02.913365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:02.433724Z","time spent":"479.636033ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5608,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"warn","ts":"2026-05-08T21:13:02.913339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:02.107339Z","time spent":"805.989199ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":74791,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-05-08T21:13:02.912877Z","caller":"traceutil/trace.go:171","msg":"trace[1635752499] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"245.078725ms","start":"2026-05-08T21:13:02.667732Z","end":"2026-05-08T21:13:02.912811Z","steps":["trace[1635752499] 'process raft request' (duration: 244.935661ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:02.914517Z","caller":"traceutil/trace.go:171","msg":"trace[1825751377] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"645.256509ms","start":"2026-05-08T21:13:02.267509Z","end":"2026-05-08T21:13:02.912765Z","steps":["trace[1825751377] 'process raft request' (duration: 644.961762ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:02.914599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:02.267473Z","time spent":"647.079711ms","remote":"127.0.0.1:39940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T21:13:08.904908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.611591ms","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-05-08T21:13:08.905029Z","caller":"traceutil/trace.go:171","msg":"trace[428766134] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:680; }","duration":"246.769204ms","start":"2026-05-08T21:13:08.658233Z","end":"2026-05-08T21:13:08.905003Z","steps":["trace[428766134] 'range keys from in-memory index tree' (duration: 246.466678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.905122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.196402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:08.905189Z","caller":"traceutil/trace.go:171","msg":"trace[1576087934] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:680; }","duration":"246.284513ms","start":"2026-05-08T21:13:08.65889Z","end":"2026-05-08T21:13:08.905174Z","steps":["trace[1576087934] 'range keys from in-memory index tree' (duration: 246.15073ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.905488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.897566ms","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-05-08T21:13:08.905563Z","caller":"traceutil/trace.go:171","msg":"trace[1126114820] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:680; }","duration":"112.997288ms","start":"2026-05-08T21:13:08.792538Z","end":"2026-05-08T21:13:08.905535Z","steps":["trace[1126114820] 'range keys from in-memory index tree' (duration: 112.807544ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.905636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.634653ms","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-05-08T21:13:08.905748Z","caller":"traceutil/trace.go:171","msg":"trace[399175333] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:680; }","duration":"272.787307ms","start":"2026-05-08T21:13:08.632938Z","end":"2026-05-08T21:13:08.905725Z","steps":["trace[399175333] 'count revisions from in-memory index tree' (duration: 272.561301ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.905908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.564033ms","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-05-08T21:13:08.905941Z","caller":"traceutil/trace.go:171","msg":"trace[112163437] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:680; }","duration":"247.626135ms","start":"2026-05-08T21:13:08.658306Z","end":"2026-05-08T21:13:08.905932Z","steps":["trace[112163437] 'count revisions from in-memory index tree' (duration: 247.529462ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:08.905445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.807664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:13:08.905925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.646774ms","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-05-08T21:13:08.906244Z","caller":"traceutil/trace.go:171","msg":"trace[1044457942] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:680; }","duration":"273.385751ms","start":"2026-05-08T21:13:08.632833Z","end":"2026-05-08T21:13:08.906219Z","steps":["trace[1044457942] 'range keys from in-memory index tree' (duration: 272.48663ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:08.906302Z","caller":"traceutil/trace.go:171","msg":"trace[1233017096] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:680; }","duration":"113.566442ms","start":"2026-05-08T21:13:08.792519Z","end":"2026-05-08T21:13:08.906085Z","steps":["trace[1233017096] 'count revisions from in-memory index tree' (duration: 112.66046ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:09.483616Z","caller":"traceutil/trace.go:171","msg":"trace[1199805550] linearizableReadLoop","detail":"{readStateIndex:706; appliedIndex:705; }","duration":"350.631608ms","start":"2026-05-08T21:13:09.132959Z","end":"2026-05-08T21:13:09.48359Z","steps":["trace[1199805550] 'read index received' (duration: 350.410003ms)","trace[1199805550] 'applied index is now lower than readState.Index' (duration: 220.745µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:13:09.483752Z","caller":"traceutil/trace.go:171","msg":"trace[1630955201] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"354.680323ms","start":"2026-05-08T21:13:09.129037Z","end":"2026-05-08T21:13:09.483717Z","steps":["trace[1630955201] 'process raft request' (duration: 354.404197ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.483881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.893944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:13:09.483896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.129024Z","time spent":"354.797976ms","remote":"127.0.0.1:40058","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:13:09.483929Z","caller":"traceutil/trace.go:171","msg":"trace[1639086980] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:683; }","duration":"350.974916ms","start":"2026-05-08T21:13:09.132942Z","end":"2026-05-08T21:13:09.483917Z","steps":["trace[1639086980] 'agreement among raft nodes before linearized reading' (duration: 350.781651ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.483957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.835213ms","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-05-08T21:13:09.484746Z","caller":"traceutil/trace.go:171","msg":"trace[576778098] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:683; }","duration":"351.661422ms","start":"2026-05-08T21:13:09.133068Z","end":"2026-05-08T21:13:09.48473Z","steps":["trace[576778098] 'agreement among raft nodes before linearized reading' (duration: 350.770531ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.133053Z","time spent":"351.712433ms","remote":"127.0.0.1:59094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:13:09.483972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.132935Z","time spent":"351.026277ms","remote":"127.0.0.1:59094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"warn","ts":"2026-05-08T21:13:09.48409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.342058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.485021Z","caller":"traceutil/trace.go:171","msg":"trace[867859976] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:683; }","duration":"248.28787ms","start":"2026-05-08T21:13:09.236714Z","end":"2026-05-08T21:13:09.485002Z","steps":["trace[867859976] 'agreement among raft nodes before linearized reading' (duration: 247.349058ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.322504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.485368Z","caller":"traceutil/trace.go:171","msg":"trace[21890869] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:683; }","duration":"142.580294ms","start":"2026-05-08T21:13:09.342775Z","end":"2026-05-08T21:13:09.485355Z","steps":["trace[21890869] 'agreement among raft nodes before linearized reading' (duration: 141.340905ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.349647ms","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-05-08T21:13:09.485533Z","caller":"traceutil/trace.go:171","msg":"trace[632294126] 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:683; }","duration":"273.752429ms","start":"2026-05-08T21:13:09.211755Z","end":"2026-05-08T21:13:09.485508Z","steps":["trace[632294126] 'agreement among raft nodes before linearized reading' (duration: 272.321836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.379405ms","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-05-08T21:13:09.485767Z","caller":"traceutil/trace.go:171","msg":"trace[1944648318] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:683; }","duration":"142.998254ms","start":"2026-05-08T21:13:09.342733Z","end":"2026-05-08T21:13:09.485731Z","steps":["trace[1944648318] 'agreement among raft nodes before linearized reading' (duration: 141.405876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.48413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.012376ms","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-05-08T21:13:09.485915Z","caller":"traceutil/trace.go:171","msg":"trace[1632134041] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:683; }","duration":"142.84358ms","start":"2026-05-08T21:13:09.343065Z","end":"2026-05-08T21:13:09.485909Z","steps":["trace[1632134041] 'agreement among raft nodes before linearized reading' (duration: 140.996336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.310125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.486139Z","caller":"traceutil/trace.go:171","msg":"trace[1287787366] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:683; }","duration":"166.284151ms","start":"2026-05-08T21:13:09.319842Z","end":"2026-05-08T21:13:09.486126Z","steps":["trace[1287787366] 'agreement among raft nodes before linearized reading' (duration: 164.315295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.176778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.486355Z","caller":"traceutil/trace.go:171","msg":"trace[2016940182] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:683; }","duration":"250.38726ms","start":"2026-05-08T21:13:09.235959Z","end":"2026-05-08T21:13:09.486346Z","steps":["trace[2016940182] 'agreement among raft nodes before linearized reading' (duration: 248.191298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.042062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.486536Z","caller":"traceutil/trace.go:171","msg":"trace[561399103] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:683; }","duration":"167.415648ms","start":"2026-05-08T21:13:09.319112Z","end":"2026-05-08T21:13:09.486528Z","steps":["trace[561399103] 'agreement among raft nodes before linearized reading' (duration: 165.063323ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.083113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.486737Z","caller":"traceutil/trace.go:171","msg":"trace[1856473913] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:683; }","duration":"167.638963ms","start":"2026-05-08T21:13:09.31909Z","end":"2026-05-08T21:13:09.486729Z","steps":["trace[1856473913] 'agreement among raft nodes before linearized reading' (duration: 165.105893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.260689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.486895Z","caller":"traceutil/trace.go:171","msg":"trace[1360395283] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:683; }","duration":"250.971054ms","start":"2026-05-08T21:13:09.235908Z","end":"2026-05-08T21:13:09.486879Z","steps":["trace[1360395283] 'agreement among raft nodes before linearized reading' (duration: 248.27559ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.669594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.487061Z","caller":"traceutil/trace.go:171","msg":"trace[74135340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"224.518882ms","start":"2026-05-08T21:13:09.262532Z","end":"2026-05-08T21:13:09.487051Z","steps":["trace[74135340] 'agreement among raft nodes before linearized reading' (duration: 221.682435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.799734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.487211Z","caller":"traceutil/trace.go:171","msg":"trace[1876170180] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:683; }","duration":"226.770854ms","start":"2026-05-08T21:13:09.260425Z","end":"2026-05-08T21:13:09.487196Z","steps":["trace[1876170180] 'agreement among raft nodes before linearized reading' (duration: 223.804114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.258945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.487429Z","caller":"traceutil/trace.go:171","msg":"trace[1289440713] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:683; }","duration":"227.394348ms","start":"2026-05-08T21:13:09.259981Z","end":"2026-05-08T21:13:09.487376Z","steps":["trace[1289440713] 'agreement among raft nodes before linearized reading' (duration: 224.264155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.812164ms","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-05-08T21:13:09.487597Z","caller":"traceutil/trace.go:171","msg":"trace[1262300288] 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:683; }","duration":"275.157973ms","start":"2026-05-08T21:13:09.21243Z","end":"2026-05-08T21:13:09.487588Z","steps":["trace[1262300288] 'agreement among raft nodes before linearized reading' (duration: 271.795993ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.306856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.487742Z","caller":"traceutil/trace.go:171","msg":"trace[215124826] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:683; }","duration":"227.761018ms","start":"2026-05-08T21:13:09.259963Z","end":"2026-05-08T21:13:09.487724Z","steps":["trace[215124826] 'agreement among raft nodes before linearized reading' (duration: 224.301096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.403879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.487829Z","caller":"traceutil/trace.go:171","msg":"trace[1395771912] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:683; }","duration":"298.951042ms","start":"2026-05-08T21:13:09.188865Z","end":"2026-05-08T21:13:09.487816Z","steps":["trace[1395771912] 'agreement among raft nodes before linearized reading' (duration: 295.423619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.777764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.487964Z","caller":"traceutil/trace.go:171","msg":"trace[1779311830] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:683; }","duration":"298.43427ms","start":"2026-05-08T21:13:09.189521Z","end":"2026-05-08T21:13:09.487955Z","steps":["trace[1779311830] 'agreement among raft nodes before linearized reading' (duration: 294.785364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.213213ms","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-05-08T21:13:09.48811Z","caller":"traceutil/trace.go:171","msg":"trace[974469961] 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:683; }","duration":"276.060394ms","start":"2026-05-08T21:13:09.21204Z","end":"2026-05-08T21:13:09.488101Z","steps":["trace[974469961] 'agreement among raft nodes before linearized reading' (duration: 272.225523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.537089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.488274Z","caller":"traceutil/trace.go:171","msg":"trace[1269714894] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"111.432391ms","start":"2026-05-08T21:13:09.376823Z","end":"2026-05-08T21:13:09.488255Z","steps":["trace[1269714894] 'agreement among raft nodes before linearized reading' (duration: 107.541579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.799294ms","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-05-08T21:13:09.48851Z","caller":"traceutil/trace.go:171","msg":"trace[1117121709] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:683; }","duration":"122.901911ms","start":"2026-05-08T21:13:09.365588Z","end":"2026-05-08T21:13:09.48849Z","steps":["trace[1117121709] 'agreement among raft nodes before linearized reading' (duration: 118.798314ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.831745ms","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-05-08T21:13:09.488707Z","caller":"traceutil/trace.go:171","msg":"trace[1625950710] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:683; }","duration":"123.123987ms","start":"2026-05-08T21:13:09.365574Z","end":"2026-05-08T21:13:09.488698Z","steps":["trace[1625950710] 'agreement among raft nodes before linearized reading' (duration: 118.833935ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.48444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.842212ms","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-05-08T21:13:09.488867Z","caller":"traceutil/trace.go:171","msg":"trace[915656163] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:683; }","duration":"122.305967ms","start":"2026-05-08T21:13:09.366553Z","end":"2026-05-08T21:13:09.488859Z","steps":["trace[915656163] 'agreement among raft nodes before linearized reading' (duration: 117.853782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.992227ms","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-05-08T21:13:09.489067Z","caller":"traceutil/trace.go:171","msg":"trace[256933893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:683; }","duration":"355.587765ms","start":"2026-05-08T21:13:09.13346Z","end":"2026-05-08T21:13:09.489048Z","steps":["trace[256933893] 'agreement among raft nodes before linearized reading' (duration: 350.993757ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.489114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.133452Z","time spent":"355.644586ms","remote":"127.0.0.1:59094","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-05-08T21:13:09.484463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.216741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.489315Z","caller":"traceutil/trace.go:171","msg":"trace[1898335204] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"112.073286ms","start":"2026-05-08T21:13:09.377232Z","end":"2026-05-08T21:13:09.489305Z","steps":["trace[1898335204] 'agreement among raft nodes before linearized reading' (duration: 107.203941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.959912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.489513Z","caller":"traceutil/trace.go:171","msg":"trace[780771002] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:683; }","duration":"110.991481ms","start":"2026-05-08T21:13:09.378513Z","end":"2026-05-08T21:13:09.489504Z","steps":["trace[780771002] 'agreement among raft nodes before linearized reading' (duration: 105.971842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.484494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.640134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:13:09.489709Z","caller":"traceutil/trace.go:171","msg":"trace[457406661] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:683; }","duration":"300.893358ms","start":"2026-05-08T21:13:09.188803Z","end":"2026-05-08T21:13:09.489696Z","steps":["trace[457406661] 'agreement among raft nodes before linearized reading' (duration: 295.560472ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:09.491778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.188788Z","time spent":"302.973377ms","remote":"127.0.0.1:59106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:13:10.411229Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269077163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:13:10.911929Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269077163,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:13:11.112199Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.457718509s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T21:13:11.112615Z","caller":"traceutil/trace.go:171","msg":"trace[931718889] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"1.458180779s","start":"2026-05-08T21:13:09.65441Z","end":"2026-05-08T21:13:11.11259Z","steps":["trace[931718889] 'process raft request' (duration: 1.458042026s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:11.112766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.654397Z","time spent":"1.458285942s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:13:11.128108Z","caller":"traceutil/trace.go:171","msg":"trace[384203640] linearizableReadLoop","detail":"{readStateIndex:708; appliedIndex:706; }","duration":"1.217633431s","start":"2026-05-08T21:13:09.910453Z","end":"2026-05-08T21:13:11.128087Z","steps":["trace[384203640] 'read index received' (duration: 1.201999473s)","trace[384203640] 'applied index is now lower than readState.Index' (duration: 15.633118ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:13:11.128149Z","caller":"traceutil/trace.go:171","msg":"trace[1824615066] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"1.473185273s","start":"2026-05-08T21:13:09.654943Z","end":"2026-05-08T21:13:11.128129Z","steps":["trace[1824615066] 'process raft request' (duration: 1.473009659s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:11.128239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.654911Z","time spent":"1.473287135s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:13:11.128248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.868858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:13:11.128501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.825317ms","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-05-08T21:13:11.128561Z","caller":"traceutil/trace.go:171","msg":"trace[501034731] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:685; }","duration":"178.925159ms","start":"2026-05-08T21:13:10.949622Z","end":"2026-05-08T21:13:11.128547Z","steps":["trace[501034731] 'agreement among raft nodes before linearized reading' (duration: 178.654652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:11.128371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.289075ms","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-05-08T21:13:11.128672Z","caller":"traceutil/trace.go:171","msg":"trace[1253395597] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:685; }","duration":"167.608952ms","start":"2026-05-08T21:13:10.961054Z","end":"2026-05-08T21:13:11.128663Z","steps":["trace[1253395597] 'agreement among raft nodes before linearized reading' (duration: 167.225003ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:11.128351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.217851957s","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-05-08T21:13:11.128755Z","caller":"traceutil/trace.go:171","msg":"trace[1194827055] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:685; }","duration":"1.218322137s","start":"2026-05-08T21:13:09.91042Z","end":"2026-05-08T21:13:11.128742Z","steps":["trace[1194827055] 'agreement among raft nodes before linearized reading' (duration: 1.217740623s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:11.1288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:09.910406Z","time spent":"1.218382089s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T21:13:11.128539Z","caller":"traceutil/trace.go:171","msg":"trace[1292627590] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"866.133344ms","start":"2026-05-08T21:13:10.262313Z","end":"2026-05-08T21:13:11.128446Z","steps":["trace[1292627590] 'agreement among raft nodes before linearized reading' (duration: 865.882038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:11.129063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:13:10.262292Z","time spent":"866.680817ms","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T21:13:26.512864Z","caller":"traceutil/trace.go:171","msg":"trace[1305109111] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"119.272426ms","start":"2026-05-08T21:13:26.393568Z","end":"2026-05-08T21:13:26.51284Z","steps":["trace[1305109111] 'process raft request' (duration: 119.146663ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:13:33.467392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.42422ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:13:33.467599Z","caller":"traceutil/trace.go:171","msg":"trace[202558047] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"193.034091ms","start":"2026-05-08T21:13:33.274549Z","end":"2026-05-08T21:13:33.467583Z","steps":["trace[202558047] 'process raft request' (duration: 192.96829ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:33.467602Z","caller":"traceutil/trace.go:171","msg":"trace[826924629] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"193.222625ms","start":"2026-05-08T21:13:33.274341Z","end":"2026-05-08T21:13:33.467563Z","steps":["trace[826924629] 'process raft request' (duration: 50.382625ms)","trace[826924629] 'compare' (duration: 142.294737ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:13:33.467725Z","caller":"traceutil/trace.go:171","msg":"trace[1938347441] linearizableReadLoop","detail":"{readStateIndex:904; appliedIndex:901; }","duration":"155.344844ms","start":"2026-05-08T21:13:33.312374Z","end":"2026-05-08T21:13:33.467719Z","steps":["trace[1938347441] 'read index received' (duration: 12.388922ms)","trace[1938347441] 'applied index is now lower than readState.Index' (duration: 142.955322ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:13:33.467869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.500118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.229\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T21:13:33.467893Z","caller":"traceutil/trace.go:171","msg":"trace[1674649860] range","detail":"{range_begin:/registry/masterleases/199.204.45.229; range_end:; response_count:1; response_revision:875; }","duration":"155.578399ms","start":"2026-05-08T21:13:33.312307Z","end":"2026-05-08T21:13:33.467885Z","steps":["trace[1674649860] 'agreement among raft nodes before linearized reading' (duration: 155.440226ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:33.46799Z","caller":"traceutil/trace.go:171","msg":"trace[1738538994] transaction","detail":"{read_only:false; response_revision:875; number_of_response:1; }","duration":"192.789525ms","start":"2026-05-08T21:13:33.275188Z","end":"2026-05-08T21:13:33.467978Z","steps":["trace[1738538994] 'process raft request' (duration: 192.365366ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:33.657173Z","caller":"traceutil/trace.go:171","msg":"trace[1767444478] transaction","detail":"{read_only:false; response_revision:877; number_of_response:1; }","duration":"183.425894ms","start":"2026-05-08T21:13:33.473721Z","end":"2026-05-08T21:13:33.657146Z","steps":["trace[1767444478] 'process raft request' (duration: 183.360453ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:33.65722Z","caller":"traceutil/trace.go:171","msg":"trace[1149268008] transaction","detail":"{read_only:false; response_revision:876; number_of_response:1; }","duration":"188.312719ms","start":"2026-05-08T21:13:33.468875Z","end":"2026-05-08T21:13:33.657187Z","steps":["trace[1149268008] 'process raft request' (duration: 188.063754ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:59.845819Z","caller":"traceutil/trace.go:171","msg":"trace[248745618] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"205.263858ms","start":"2026-05-08T21:13:59.640531Z","end":"2026-05-08T21:13:59.845795Z","steps":["trace[248745618] 'process raft request' (duration: 205.234967ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:13:59.845856Z","caller":"traceutil/trace.go:171","msg":"trace[142845225] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"206.075587ms","start":"2026-05-08T21:13:59.639736Z","end":"2026-05-08T21:13:59.845812Z","steps":["trace[142845225] 'process raft request' (duration: 181.079713ms)","trace[142845225] 'compare' (duration: 24.862451ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:01.343348Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269077819,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:14:01.676129Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.271493143s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T21:14:01.676557Z","caller":"traceutil/trace.go:171","msg":"trace[1492796278] linearizableReadLoop","detail":"{readStateIndex:1046; appliedIndex:1045; }","duration":"833.398102ms","start":"2026-05-08T21:14:00.84313Z","end":"2026-05-08T21:14:01.676528Z","steps":["trace[1492796278] 'read index received' (duration: 833.243478ms)","trace[1492796278] 'applied index is now lower than readState.Index' (duration: 153.254µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:01.676703Z","caller":"traceutil/trace.go:171","msg":"trace[2109653263] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"1.272137028s","start":"2026-05-08T21:14:00.404521Z","end":"2026-05-08T21:14:01.676658Z","steps":["trace[2109653263] 'process raft request' (duration: 1.271860321s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.67677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"833.623258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:14:01.676813Z","caller":"traceutil/trace.go:171","msg":"trace[711390201] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1009; }","duration":"833.72604ms","start":"2026-05-08T21:14:00.843075Z","end":"2026-05-08T21:14:01.676801Z","steps":["trace[711390201] 'agreement among raft nodes before linearized reading' (duration: 833.637788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.676851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:00.843053Z","time spent":"833.788761ms","remote":"127.0.0.1:40192","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:14:01.676947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.299555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:14:01.676915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:00.404496Z","time spent":"1.272268901s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:01.677018Z","caller":"traceutil/trace.go:171","msg":"trace[1977658144] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1009; }","duration":"414.412418ms","start":"2026-05-08T21:14:01.262584Z","end":"2026-05-08T21:14:01.676996Z","steps":["trace[1977658144] 'agreement among raft nodes before linearized reading' (duration: 414.304215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.677062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:01.26256Z","time spent":"414.495009ms","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T21:14:01.677283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.856819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-08T21:14:01.677304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.22408ms","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-05-08T21:14:01.677354Z","caller":"traceutil/trace.go:171","msg":"trace[957350141] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1009; }","duration":"339.306162ms","start":"2026-05-08T21:14:01.338037Z","end":"2026-05-08T21:14:01.677344Z","steps":["trace[957350141] 'agreement among raft nodes before linearized reading' (duration: 339.156588ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:01.677364Z","caller":"traceutil/trace.go:171","msg":"trace[769692310] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1009; }","duration":"272.977652ms","start":"2026-05-08T21:14:01.404363Z","end":"2026-05-08T21:14:01.677341Z","steps":["trace[769692310] 'agreement among raft nodes before linearized reading' (duration: 272.750756ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:01.677382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:01.338021Z","time spent":"339.355003ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T21:14:02.065187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.197959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:14:02.065294Z","caller":"traceutil/trace.go:171","msg":"trace[994236383] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"384.122459ms","start":"2026-05-08T21:14:01.681151Z","end":"2026-05-08T21:14:02.065273Z","steps":["trace[994236383] 'process raft request' (duration: 281.758866ms)","trace[994236383] 'compare' (duration: 102.071336ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:02.065367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:01.68113Z","time spent":"384.197611ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:02.071993Z","caller":"traceutil/trace.go:171","msg":"trace[639848463] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"389.345211ms","start":"2026-05-08T21:14:01.682619Z","end":"2026-05-08T21:14:02.071965Z","steps":["trace[639848463] 'process raft request' (duration: 389.064145ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:02.072108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:01.682597Z","time spent":"389.462614ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:02.072276Z","caller":"traceutil/trace.go:171","msg":"trace[1671255335] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"388.365309ms","start":"2026-05-08T21:14:01.683877Z","end":"2026-05-08T21:14:02.072242Z","steps":["trace[1671255335] 'process raft request' (duration: 387.919188ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:02.072477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:01.683862Z","time spent":"388.510852ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:02.072602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.107221ms","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-05-08T21:14:02.072681Z","caller":"traceutil/trace.go:171","msg":"trace[1871637506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1012; }","duration":"222.246376ms","start":"2026-05-08T21:14:01.850422Z","end":"2026-05-08T21:14:02.072668Z","steps":["trace[1871637506] 'agreement among raft nodes before linearized reading' (duration: 221.934368ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:02.072296Z","caller":"traceutil/trace.go:171","msg":"trace[1049313406] linearizableReadLoop","detail":"{readStateIndex:1049; appliedIndex:1046; }","duration":"221.544809ms","start":"2026-05-08T21:14:01.850486Z","end":"2026-05-08T21:14:02.072031Z","steps":["trace[1049313406] 'read index received' (duration: 112.450279ms)","trace[1049313406] 'applied index is now lower than readState.Index' (duration: 109.09334ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:02.073095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.356438ms","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-05-08T21:14:02.07316Z","caller":"traceutil/trace.go:171","msg":"trace[455333690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1012; }","duration":"222.42424ms","start":"2026-05-08T21:14:01.850722Z","end":"2026-05-08T21:14:02.073146Z","steps":["trace[455333690] 'agreement among raft nodes before linearized reading' (duration: 222.214835ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:08.333332Z","caller":"traceutil/trace.go:171","msg":"trace[1404902808] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"239.11531ms","start":"2026-05-08T21:14:08.094199Z","end":"2026-05-08T21:14:08.333314Z","steps":["trace[1404902808] 'process raft request' (duration: 237.598985ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:08.333289Z","caller":"traceutil/trace.go:171","msg":"trace[644033979] linearizableReadLoop","detail":"{readStateIndex:1070; appliedIndex:1069; }","duration":"218.15619ms","start":"2026-05-08T21:14:08.115107Z","end":"2026-05-08T21:14:08.333263Z","steps":["trace[644033979] 'read index received' (duration: 40.731513ms)","trace[644033979] 'applied index is now lower than readState.Index' (duration: 177.423247ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:08.333494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.363075ms","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-05-08T21:14:08.333562Z","caller":"traceutil/trace.go:171","msg":"trace[764276727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1032; }","duration":"218.459687ms","start":"2026-05-08T21:14:08.115085Z","end":"2026-05-08T21:14:08.333545Z","steps":["trace[764276727] 'agreement among raft nodes before linearized reading' (duration: 218.281012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:08.333655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.103679ms","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-05-08T21:14:08.333725Z","caller":"traceutil/trace.go:171","msg":"trace[1569198262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1032; }","duration":"212.20375ms","start":"2026-05-08T21:14:08.121503Z","end":"2026-05-08T21:14:08.333707Z","steps":["trace[1569198262] 'agreement among raft nodes before linearized reading' (duration: 211.992885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:08.333861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.619984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:14:08.333897Z","caller":"traceutil/trace.go:171","msg":"trace[1496509016] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:1032; }","duration":"136.687436ms","start":"2026-05-08T21:14:08.197199Z","end":"2026-05-08T21:14:08.333887Z","steps":["trace[1496509016] 'agreement among raft nodes before linearized reading' (duration: 136.627804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:08.334108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.320343ms","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-05-08T21:14:08.334144Z","caller":"traceutil/trace.go:171","msg":"trace[127810188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1032; }","duration":"200.397284ms","start":"2026-05-08T21:14:08.133739Z","end":"2026-05-08T21:14:08.334136Z","steps":["trace[127810188] 'agreement among raft nodes before linearized reading' (duration: 200.308852ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:14.017704Z","caller":"traceutil/trace.go:171","msg":"trace[1393026747] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"257.857588ms","start":"2026-05-08T21:14:13.759819Z","end":"2026-05-08T21:14:14.017677Z","steps":["trace[1393026747] 'process raft request' (duration: 257.670423ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:23.529376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.099692ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:14:23.529486Z","caller":"traceutil/trace.go:171","msg":"trace[206662852] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"176.085387ms","start":"2026-05-08T21:14:23.353381Z","end":"2026-05-08T21:14:23.529466Z","steps":["trace[206662852] 'process raft request' (duration: 45.801351ms)","trace[206662852] 'compare' (duration: 129.889957ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:25.141575Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269078019,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:14:25.895455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.283554024s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:14:25.895994Z","caller":"traceutil/trace.go:171","msg":"trace[1732666557] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"1.331563106s","start":"2026-05-08T21:14:24.564392Z","end":"2026-05-08T21:14:25.895955Z","steps":["trace[1732666557] 'process raft request' (duration: 47.409429ms)","trace[1732666557] 'compare' (duration: 1.282974829s)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:25.8962Z","caller":"traceutil/trace.go:171","msg":"trace[659827653] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"1.331240078s","start":"2026-05-08T21:14:24.56494Z","end":"2026-05-08T21:14:25.89618Z","steps":["trace[659827653] 'process raft request' (duration: 1.331143226s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:25.896205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:24.56437Z","time spent":"1.331712469s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:25.896295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:24.564923Z","time spent":"1.33133297s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:25.896355Z","caller":"traceutil/trace.go:171","msg":"trace[457453829] linearizableReadLoop","detail":"{readStateIndex:1130; appliedIndex:1126; }","duration":"1.255333203s","start":"2026-05-08T21:14:24.640969Z","end":"2026-05-08T21:14:25.896302Z","steps":["trace[457453829] 'read index received' (duration: 940.401361ms)","trace[457453829] 'applied index is now lower than readState.Index' (duration: 314.930782ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:25.896467Z","caller":"traceutil/trace.go:171","msg":"trace[1592978918] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"1.331700939s","start":"2026-05-08T21:14:24.564756Z","end":"2026-05-08T21:14:25.896457Z","steps":["trace[1592978918] 'process raft request' (duration: 1.330831918s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:25.896526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:24.564742Z","time spent":"1.33175707s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:25.896553Z","caller":"traceutil/trace.go:171","msg":"trace[1413165858] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"1.015223251s","start":"2026-05-08T21:14:24.881318Z","end":"2026-05-08T21:14:25.896542Z","steps":["trace[1413165858] 'process raft request' (duration: 1.014820091s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:25.89666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:24.881295Z","time spent":"1.015296583s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:25.896923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255957238s","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-05-08T21:14:25.896966Z","caller":"traceutil/trace.go:171","msg":"trace[649548623] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1088; }","duration":"1.25604221s","start":"2026-05-08T21:14:24.640914Z","end":"2026-05-08T21:14:25.896956Z","steps":["trace[649548623] 'agreement among raft nodes before linearized reading' (duration: 1.255971779s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:25.896999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:24.64089Z","time spent":"1.256099941s","remote":"127.0.0.1:59160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:14:25.897169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138230686s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:14:25.897203Z","caller":"traceutil/trace.go:171","msg":"trace[1683473932] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1088; }","duration":"1.138311778s","start":"2026-05-08T21:14:24.758883Z","end":"2026-05-08T21:14:25.897195Z","steps":["trace[1683473932] 'agreement among raft nodes before linearized reading' (duration: 1.138256036s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:25.89723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:24.758858Z","time spent":"1.138364929s","remote":"127.0.0.1:39970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":9,"response size":29,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:14:25.897416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.277596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:14:25.897453Z","caller":"traceutil/trace.go:171","msg":"trace[1966866655] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1088; }","duration":"444.351208ms","start":"2026-05-08T21:14:25.453093Z","end":"2026-05-08T21:14:25.897444Z","steps":["trace[1966866655] 'agreement among raft nodes before linearized reading' (duration: 444.298056ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:25.897499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:25.453073Z","time spent":"444.417299ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:14:25.897625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.321366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:14:25.897694Z","caller":"traceutil/trace.go:171","msg":"trace[1473084753] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"634.435459ms","start":"2026-05-08T21:14:25.26324Z","end":"2026-05-08T21:14:25.897676Z","steps":["trace[1473084753] 'agreement among raft nodes before linearized reading' (duration: 634.324536ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:25.897734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:25.263216Z","time spent":"634.510731ms","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T21:14:26.406654Z","caller":"traceutil/trace.go:171","msg":"trace[284194930] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"274.910966ms","start":"2026-05-08T21:14:26.131714Z","end":"2026-05-08T21:14:26.406625Z","steps":["trace[284194930] 'process raft request' (duration: 201.233784ms)","trace[284194930] 'compare' (duration: 73.58235ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:26.638254Z","caller":"traceutil/trace.go:171","msg":"trace[1086194188] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"183.779466ms","start":"2026-05-08T21:14:26.454449Z","end":"2026-05-08T21:14:26.638228Z","steps":["trace[1086194188] 'process raft request' (duration: 183.583602ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:28.564189Z","caller":"traceutil/trace.go:171","msg":"trace[956112273] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"658.78421ms","start":"2026-05-08T21:14:27.905379Z","end":"2026-05-08T21:14:28.564164Z","steps":["trace[956112273] 'process raft request' (duration: 658.657017ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:28.564353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:27.905362Z","time spent":"658.896262ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:29.01002Z","caller":"traceutil/trace.go:171","msg":"trace[439691016] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"1.104394406s","start":"2026-05-08T21:14:27.905603Z","end":"2026-05-08T21:14:29.009997Z","steps":["trace[439691016] 'process raft request' (duration: 1.104323924s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:29.010243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:27.905582Z","time spent":"1.10458736s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:29.010016Z","caller":"traceutil/trace.go:171","msg":"trace[125514502] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"1.104421656s","start":"2026-05-08T21:14:27.905562Z","end":"2026-05-08T21:14:29.009983Z","steps":["trace[125514502] 'process raft request' (duration: 1.104251482s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:29.010359Z","caller":"traceutil/trace.go:171","msg":"trace[552539188] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"1.058447672s","start":"2026-05-08T21:14:27.951889Z","end":"2026-05-08T21:14:29.010337Z","steps":["trace[552539188] 'process raft request' (duration: 1.058075213s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:29.010389Z","caller":"traceutil/trace.go:171","msg":"trace[1560062629] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"599.767259ms","start":"2026-05-08T21:14:28.410599Z","end":"2026-05-08T21:14:29.010366Z","steps":["trace[1560062629] 'process raft request' (duration: 599.592925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:29.010371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:27.905544Z","time spent":"1.104778524s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:29.01052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:28.410578Z","time spent":"599.869521ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:29.010631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:27.951872Z","time spent":"1.058559534s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:29.101763Z","caller":"traceutil/trace.go:171","msg":"trace[280371160] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1133; }","duration":"838.586752ms","start":"2026-05-08T21:14:28.263147Z","end":"2026-05-08T21:14:29.101734Z","steps":["trace[280371160] 'read index received' (duration: 300.937845ms)","trace[280371160] 'applied index is now lower than readState.Index' (duration: 537.647187ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:29.101972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.799937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:14:29.102017Z","caller":"traceutil/trace.go:171","msg":"trace[1582460259] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1096; }","duration":"838.867589ms","start":"2026-05-08T21:14:28.263132Z","end":"2026-05-08T21:14:29.102Z","steps":["trace[1582460259] 'agreement among raft nodes before linearized reading' (duration: 838.770966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:29.102091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:28.263081Z","time spent":"838.967821ms","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T21:14:29.102152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.050924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T21:14:29.102272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.299161ms","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-05-08T21:14:29.102306Z","caller":"traceutil/trace.go:171","msg":"trace[2036451232] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1096; }","duration":"549.263978ms","start":"2026-05-08T21:14:28.552988Z","end":"2026-05-08T21:14:29.102252Z","steps":["trace[2036451232] 'agreement among raft nodes before linearized reading' (duration: 548.982242ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:29.102343Z","caller":"traceutil/trace.go:171","msg":"trace[386524936] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1096; }","duration":"422.397163ms","start":"2026-05-08T21:14:28.679927Z","end":"2026-05-08T21:14:29.102325Z","steps":["trace[386524936] 'agreement among raft nodes before linearized reading' (duration: 422.187288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:29.102402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:28.679917Z","time spent":"422.476265ms","remote":"127.0.0.1:40134","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-05-08T21:14:29.102459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.092801ms","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-05-08T21:14:29.102609Z","caller":"traceutil/trace.go:171","msg":"trace[1517695772] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1096; }","duration":"459.290166ms","start":"2026-05-08T21:14:28.643285Z","end":"2026-05-08T21:14:29.102575Z","steps":["trace[1517695772] 'agreement among raft nodes before linearized reading' (duration: 458.869266ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:29.102688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:28.643269Z","time spent":"459.402398ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-08T21:14:29.102418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:28.552962Z","time spent":"549.418802ms","remote":"127.0.0.1:40276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"info","ts":"2026-05-08T21:14:29.414434Z","caller":"traceutil/trace.go:171","msg":"trace[1697635455] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"308.090412ms","start":"2026-05-08T21:14:29.106297Z","end":"2026-05-08T21:14:29.414387Z","steps":["trace[1697635455] 'process raft request' (duration: 307.830176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:29.414723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:29.106285Z","time spent":"308.264846ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:29.426442Z","caller":"traceutil/trace.go:171","msg":"trace[1081225933] linearizableReadLoop","detail":"{readStateIndex:1141; appliedIndex:1139; }","duration":"163.196845ms","start":"2026-05-08T21:14:29.26322Z","end":"2026-05-08T21:14:29.426417Z","steps":["trace[1081225933] 'read index received' (duration: 150.857737ms)","trace[1081225933] 'applied index is now lower than readState.Index' (duration: 12.338388ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:29.426612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.372249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:14:29.42668Z","caller":"traceutil/trace.go:171","msg":"trace[280404993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1098; }","duration":"163.489562ms","start":"2026-05-08T21:14:29.263178Z","end":"2026-05-08T21:14:29.426668Z","steps":["trace[280404993] 'agreement among raft nodes before linearized reading' (duration: 163.384379ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:29.426664Z","caller":"traceutil/trace.go:171","msg":"trace[1865212028] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"319.306824ms","start":"2026-05-08T21:14:29.107314Z","end":"2026-05-08T21:14:29.42662Z","steps":["trace[1865212028] 'process raft request' (duration: 318.995096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:29.426985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:29.10729Z","time spent":"319.53517ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:30.815839Z","caller":"traceutil/trace.go:171","msg":"trace[838438172] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"242.517749ms","start":"2026-05-08T21:14:30.573295Z","end":"2026-05-08T21:14:30.815813Z","steps":["trace[838438172] 'process raft request' (duration: 242.391356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:31.46896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.44106ms","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-05-08T21:14:31.469239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.504675ms","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-05-08T21:14:31.469316Z","caller":"traceutil/trace.go:171","msg":"trace[1487462370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1099; }","duration":"454.651708ms","start":"2026-05-08T21:14:31.014646Z","end":"2026-05-08T21:14:31.469298Z","steps":["trace[1487462370] 'range keys from in-memory index tree' (duration: 454.27908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:31.469365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:31.014631Z","time spent":"454.72632ms","remote":"127.0.0.1:40134","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-05-08T21:14:31.469251Z","caller":"traceutil/trace.go:171","msg":"trace[6830228] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1099; }","duration":"388.747577ms","start":"2026-05-08T21:14:31.080475Z","end":"2026-05-08T21:14:31.469223Z","steps":["trace[6830228] 'range keys from in-memory index tree' (duration: 388.41814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:31.469113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.667489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T21:14:31.469546Z","caller":"traceutil/trace.go:171","msg":"trace[937018243] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1099; }","duration":"455.17347ms","start":"2026-05-08T21:14:31.014355Z","end":"2026-05-08T21:14:31.469529Z","steps":["trace[937018243] 'range keys from in-memory index tree' (duration: 454.475394ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:31.469594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:31.014323Z","time spent":"455.261773ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-08T21:14:31.471098Z","caller":"traceutil/trace.go:171","msg":"trace[1580845589] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"455.251202ms","start":"2026-05-08T21:14:31.015822Z","end":"2026-05-08T21:14:31.471073Z","steps":["trace[1580845589] 'process raft request' (duration: 454.923245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:31.471248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:31.015807Z","time spent":"455.352584ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:32.082538Z","caller":"traceutil/trace.go:171","msg":"trace[976615693] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"609.529339ms","start":"2026-05-08T21:14:31.472958Z","end":"2026-05-08T21:14:32.082487Z","steps":["trace[976615693] 'process raft request' (duration: 578.496513ms)","trace[976615693] 'compare' (duration: 30.816411ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:32.082808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:31.472933Z","time spent":"609.744833ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:32.460889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.288164ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:14:32.461186Z","caller":"traceutil/trace.go:171","msg":"trace[388880321] linearizableReadLoop","detail":"{readStateIndex:1147; appliedIndex:1144; }","duration":"198.151542ms","start":"2026-05-08T21:14:32.263011Z","end":"2026-05-08T21:14:32.461162Z","steps":["trace[388880321] 'read index received' (duration: 91.53789ms)","trace[388880321] 'applied index is now lower than readState.Index' (duration: 106.612132ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:32.461284Z","caller":"traceutil/trace.go:171","msg":"trace[592886792] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"986.832508ms","start":"2026-05-08T21:14:31.474441Z","end":"2026-05-08T21:14:32.461274Z","steps":["trace[592886792] 'process raft request' (duration: 986.580432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:32.461352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:31.474428Z","time spent":"986.889089ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:14:32.461322Z","caller":"traceutil/trace.go:171","msg":"trace[205875938] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"988.039336ms","start":"2026-05-08T21:14:31.473236Z","end":"2026-05-08T21:14:32.461276Z","steps":["trace[205875938] 'process raft request' (duration: 881.265101ms)","trace[205875938] 'compare' (duration: 105.723221ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:32.461626Z","caller":"traceutil/trace.go:171","msg":"trace[843295560] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"986.04179ms","start":"2026-05-08T21:14:31.475555Z","end":"2026-05-08T21:14:32.461597Z","steps":["trace[843295560] 'process raft request' (duration: 985.563529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:32.46169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.658293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:14:32.461758Z","caller":"traceutil/trace.go:171","msg":"trace[1342242126] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1104; }","duration":"198.796717ms","start":"2026-05-08T21:14:32.262947Z","end":"2026-05-08T21:14:32.461744Z","steps":["trace[1342242126] 'agreement among raft nodes before linearized reading' (duration: 198.668194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:32.461756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:31.475531Z","time spent":"986.163063ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:32.461543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:31.473217Z","time spent":"988.219391ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:32.461974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.101283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:14:32.462525Z","caller":"traceutil/trace.go:171","msg":"trace[1895007603] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1104; }","duration":"110.608386ms","start":"2026-05-08T21:14:32.351832Z","end":"2026-05-08T21:14:32.46244Z","steps":["trace[1895007603] 'agreement among raft nodes before linearized reading' (duration: 110.074693ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:40.664558Z","caller":"traceutil/trace.go:171","msg":"trace[1750717871] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"166.711067ms","start":"2026-05-08T21:14:40.497827Z","end":"2026-05-08T21:14:40.664538Z","steps":["trace[1750717871] 'process raft request' (duration: 166.680476ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:40.664577Z","caller":"traceutil/trace.go:171","msg":"trace[186491966] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"166.874241ms","start":"2026-05-08T21:14:40.49767Z","end":"2026-05-08T21:14:40.664544Z","steps":["trace[186491966] 'process raft request' (duration: 166.711987ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:41.038139Z","caller":"traceutil/trace.go:171","msg":"trace[1749588764] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"174.600711ms","start":"2026-05-08T21:14:40.863509Z","end":"2026-05-08T21:14:41.03811Z","steps":["trace[1749588764] 'process raft request' (duration: 174.437908ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:45.241234Z","caller":"traceutil/trace.go:171","msg":"trace[1475780821] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"187.149695ms","start":"2026-05-08T21:14:45.054052Z","end":"2026-05-08T21:14:45.241202Z","steps":["trace[1475780821] 'process raft request' (duration: 186.963131ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:14:48.577637Z","caller":"traceutil/trace.go:171","msg":"trace[2116714022] linearizableReadLoop","detail":"{readStateIndex:1254; appliedIndex:1253; }","duration":"314.509902ms","start":"2026-05-08T21:14:48.263108Z","end":"2026-05-08T21:14:48.577618Z","steps":["trace[2116714022] 'read index received' (duration: 314.298747ms)","trace[2116714022] 'applied index is now lower than readState.Index' (duration: 210.265µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:14:48.577743Z","caller":"traceutil/trace.go:171","msg":"trace[165700441] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"338.204856ms","start":"2026-05-08T21:14:48.239506Z","end":"2026-05-08T21:14:48.577711Z","steps":["trace[165700441] 'process raft request' (duration: 337.96216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:48.577779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.689826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-08T21:14:48.577805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.311281ms","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-05-08T21:14:48.577824Z","caller":"traceutil/trace.go:171","msg":"trace[2135846050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1206; }","duration":"314.823989ms","start":"2026-05-08T21:14:48.262989Z","end":"2026-05-08T21:14:48.577813Z","steps":["trace[2135846050] 'agreement among raft nodes before linearized reading' (duration: 314.714317ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:48.57785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:48.262968Z","time spent":"314.87456ms","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T21:14:48.577857Z","caller":"traceutil/trace.go:171","msg":"trace[1892563466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1206; }","duration":"250.403963ms","start":"2026-05-08T21:14:48.327426Z","end":"2026-05-08T21:14:48.57783Z","steps":["trace[1892563466] 'agreement among raft nodes before linearized reading' (duration: 250.312581ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:48.577888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:48.239483Z","time spent":"338.337069ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:49.142316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.333625ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:14:49.142686Z","caller":"traceutil/trace.go:171","msg":"trace[2104830178] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"561.090757ms","start":"2026-05-08T21:14:48.581545Z","end":"2026-05-08T21:14:49.142635Z","steps":["trace[2104830178] 'process raft request' (duration: 315.376813ms)","trace[2104830178] 'compare' (duration: 245.168641ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:49.14284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:48.581521Z","time spent":"561.24142ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:14:49.414379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.981138ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-08T21:14:49.414448Z","caller":"traceutil/trace.go:171","msg":"trace[882514125] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1254; }","duration":"718.793732ms","start":"2026-05-08T21:14:48.695643Z","end":"2026-05-08T21:14:49.414436Z","steps":["trace[882514125] 'read index received' (duration: 201.287925ms)","trace[882514125] 'applied index is now lower than readState.Index' (duration: 517.504837ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:14:49.414639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.490212ms","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-05-08T21:14:49.414664Z","caller":"traceutil/trace.go:171","msg":"trace[1980886006] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1207; }","duration":"160.558874ms","start":"2026-05-08T21:14:49.254099Z","end":"2026-05-08T21:14:49.414658Z","steps":["trace[1980886006] 'agreement among raft nodes before linearized reading' (duration: 160.42372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:49.414648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.986508ms","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-05-08T21:14:49.414712Z","caller":"traceutil/trace.go:171","msg":"trace[824620861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1207; }","duration":"719.088059ms","start":"2026-05-08T21:14:48.695606Z","end":"2026-05-08T21:14:49.414694Z","steps":["trace[824620861] 'agreement among raft nodes before linearized reading' (duration: 718.889105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:49.414741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:48.69559Z","time spent":"719.144891ms","remote":"127.0.0.1:40134","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-05-08T21:14:49.414741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.552227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T21:14:49.414872Z","caller":"traceutil/trace.go:171","msg":"trace[307631617] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1207; }","duration":"718.699421ms","start":"2026-05-08T21:14:48.696154Z","end":"2026-05-08T21:14:49.414853Z","steps":["trace[307631617] 'agreement among raft nodes before linearized reading' (duration: 718.358813ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:14:49.414926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:14:48.696117Z","time spent":"718.799393ms","remote":"127.0.0.1:40134","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-05-08T21:15:06.575402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056630551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T21:15:06.575482Z","caller":"traceutil/trace.go:171","msg":"trace[1798168856] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1288; }","duration":"1.056741394s","start":"2026-05-08T21:15:05.518722Z","end":"2026-05-08T21:15:06.575464Z","steps":["trace[1798168856] 'count revisions from in-memory index tree' (duration: 1.05655821s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:06.575489Z","caller":"traceutil/trace.go:171","msg":"trace[59006002] linearizableReadLoop","detail":"{readStateIndex:1341; appliedIndex:1340; }","duration":"313.514204ms","start":"2026-05-08T21:15:06.261947Z","end":"2026-05-08T21:15:06.575461Z","steps":["trace[59006002] 'read index received' (duration: 304.27935ms)","trace[59006002] 'applied index is now lower than readState.Index' (duration: 9.233874ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:06.575507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069862179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-08T21:15:06.57554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:05.518711Z","time spent":"1.056817726s","remote":"127.0.0.1:40358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":3,"response size":29,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:15:06.57555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.069601344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-08T21:15:06.575589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.628037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:06.575577Z","caller":"traceutil/trace.go:171","msg":"trace[878460258] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1288; }","duration":"1.070006983s","start":"2026-05-08T21:15:05.505551Z","end":"2026-05-08T21:15:06.575558Z","steps":["trace[878460258] 'range keys from in-memory index tree' (duration: 1.069668445s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:06.575613Z","caller":"traceutil/trace.go:171","msg":"trace[1945822631] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1289; }","duration":"313.701509ms","start":"2026-05-08T21:15:06.261904Z","end":"2026-05-08T21:15:06.575606Z","steps":["trace[1945822631] 'agreement among raft nodes before linearized reading' (duration: 313.628087ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:06.575632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:06.261886Z","time spent":"313.741549ms","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T21:15:06.575628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:05.505527Z","time spent":"1.070091845s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T21:15:06.575628Z","caller":"traceutil/trace.go:171","msg":"trace[1493526866] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1288; }","duration":"1.069722626s","start":"2026-05-08T21:15:05.505885Z","end":"2026-05-08T21:15:06.575608Z","steps":["trace[1493526866] 'range keys from in-memory index tree' (duration: 1.069402489s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:06.57567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:05.505868Z","time spent":"1.069793888s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-08T21:15:06.575713Z","caller":"traceutil/trace.go:171","msg":"trace[644108276] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"793.260332ms","start":"2026-05-08T21:15:05.782433Z","end":"2026-05-08T21:15:06.575693Z","steps":["trace[644108276] 'process raft request' (duration: 783.753601ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:06.575816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:05.782409Z","time spent":"793.345884ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:07.16557Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269078491,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T21:15:07.23367Z","caller":"traceutil/trace.go:171","msg":"trace[9226589] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1341; }","duration":"568.799566ms","start":"2026-05-08T21:15:06.664849Z","end":"2026-05-08T21:15:07.233649Z","steps":["trace[9226589] 'read index received' (duration: 514.967436ms)","trace[9226589] 'applied index is now lower than readState.Index' (duration: 53.83156ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:07.233811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.95137ms","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-05-08T21:15:07.233833Z","caller":"traceutil/trace.go:171","msg":"trace[134100434] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1292; }","duration":"569.027802ms","start":"2026-05-08T21:15:06.664799Z","end":"2026-05-08T21:15:07.233827Z","steps":["trace[134100434] 'agreement among raft nodes before linearized reading' (duration: 568.914969ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:07.233849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:06.66478Z","time spent":"569.065452ms","remote":"127.0.0.1:40134","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-05-08T21:15:07.234139Z","caller":"traceutil/trace.go:171","msg":"trace[658022035] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"394.812994ms","start":"2026-05-08T21:15:06.839315Z","end":"2026-05-08T21:15:07.234128Z","steps":["trace[658022035] 'process raft request' (duration: 394.316182ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:07.234149Z","caller":"traceutil/trace.go:171","msg":"trace[2089301365] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"654.067307ms","start":"2026-05-08T21:15:06.580055Z","end":"2026-05-08T21:15:07.234122Z","steps":["trace[2089301365] 'process raft request' (duration: 599.747025ms)","trace[2089301365] 'compare' (duration: 53.626886ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:07.234196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:06.839289Z","time spent":"394.868474ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:15:07.234242Z","caller":"traceutil/trace.go:171","msg":"trace[693738431] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"652.614873ms","start":"2026-05-08T21:15:06.581621Z","end":"2026-05-08T21:15:07.234236Z","steps":["trace[693738431] 'process raft request' (duration: 651.989719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:07.234264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:06.581605Z","time spent":"652.646054ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:07.234263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:06.580035Z","time spent":"654.166519ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:07.49246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.65691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:15:07.492659Z","caller":"traceutil/trace.go:171","msg":"trace[2076875798] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"254.162386ms","start":"2026-05-08T21:15:07.238456Z","end":"2026-05-08T21:15:07.492618Z","steps":["trace[2076875798] 'process raft request' (duration: 97.181828ms)","trace[2076875798] 'compare' (duration: 156.444965ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:07.49275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.176504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:07.492794Z","caller":"traceutil/trace.go:171","msg":"trace[338869751] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1293; }","duration":"229.236067ms","start":"2026-05-08T21:15:07.263548Z","end":"2026-05-08T21:15:07.492784Z","steps":["trace[338869751] 'agreement among raft nodes before linearized reading' (duration: 229.129284ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:07.492964Z","caller":"traceutil/trace.go:171","msg":"trace[322339970] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"229.043862ms","start":"2026-05-08T21:15:07.263562Z","end":"2026-05-08T21:15:07.492606Z","steps":["trace[322339970] 'read index received' (duration: 72.031203ms)","trace[322339970] 'applied index is now lower than readState.Index' (duration: 157.011019ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:07.493432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.297128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-08T21:15:07.493538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.474883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:07.493568Z","caller":"traceutil/trace.go:171","msg":"trace[193716095] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1293; }","duration":"217.546125ms","start":"2026-05-08T21:15:07.276015Z","end":"2026-05-08T21:15:07.493561Z","steps":["trace[193716095] 'agreement among raft nodes before linearized reading' (duration: 217.496084ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:07.493499Z","caller":"traceutil/trace.go:171","msg":"trace[333916318] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1293; }","duration":"226.37007ms","start":"2026-05-08T21:15:07.267114Z","end":"2026-05-08T21:15:07.493484Z","steps":["trace[333916318] 'agreement among raft nodes before linearized reading' (duration: 226.059863ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:09.144899Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269078502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:15:09.581664Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.122623334s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T21:15:09.582087Z","caller":"traceutil/trace.go:171","msg":"trace[785651277] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"1.123111816s","start":"2026-05-08T21:15:08.458946Z","end":"2026-05-08T21:15:09.582058Z","steps":["trace[785651277] 'process raft request' (duration: 1.122907881s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:09.582281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:08.458928Z","time spent":"1.123244339s","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6105,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:10.644551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000080252s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-08T21:15:10.644643Z","caller":"traceutil/trace.go:171","msg":"trace[370458462] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000224915s","start":"2026-05-08T21:15:08.644396Z","end":"2026-05-08T21:15:10.644621Z","steps":["trace[370458462] 'agreement among raft nodes before linearized reading' (duration: 2.000111533s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:10.64469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:08.644377Z","time spent":"2.000304667s","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T21:15:11.169554Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.58768615s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T21:15:11.169955Z","caller":"traceutil/trace.go:171","msg":"trace[635374595] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"2.588919243s","start":"2026-05-08T21:15:08.580983Z","end":"2026-05-08T21:15:11.169903Z","steps":["trace[635374595] 'process raft request' (duration: 2.588741249s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.170109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:08.580953Z","time spent":"2.589064697s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:15:11.202272Z","caller":"traceutil/trace.go:171","msg":"trace[318330206] linearizableReadLoop","detail":"{readStateIndex:1350; appliedIndex:1347; }","duration":"2.557796991s","start":"2026-05-08T21:15:08.644444Z","end":"2026-05-08T21:15:11.202241Z","steps":["trace[318330206] 'read index received' (duration: 937.495103ms)","trace[318330206] 'applied index is now lower than readState.Index' (duration: 1.620299228s)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:11.202407Z","caller":"traceutil/trace.go:171","msg":"trace[132355134] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"553.808838ms","start":"2026-05-08T21:15:10.64857Z","end":"2026-05-08T21:15:11.202378Z","steps":["trace[132355134] 'process raft request' (duration: 553.753977ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:11.202463Z","caller":"traceutil/trace.go:171","msg":"trace[275469356] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"1.367931615s","start":"2026-05-08T21:15:09.834508Z","end":"2026-05-08T21:15:11.20244Z","steps":["trace[275469356] 'process raft request' (duration: 1.367668828s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.202561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:10.648542Z","time spent":"553.949642ms","remote":"127.0.0.1:39948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":758,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T21:15:11.202617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.834478Z","time spent":"1.368045177s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:11.2029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.66942828s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-08T21:15:11.202973Z","caller":"traceutil/trace.go:171","msg":"trace[252941408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1299; }","duration":"1.669500301s","start":"2026-05-08T21:15:09.533455Z","end":"2026-05-08T21:15:11.202956Z","steps":["trace[252941408] 'agreement among raft nodes before linearized reading' (duration: 1.669156534s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.202988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.964539317s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-08T21:15:11.203029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.533422Z","time spent":"1.669593633s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-08T21:15:11.203078Z","caller":"traceutil/trace.go:171","msg":"trace[1394990104] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1299; }","duration":"1.964625489s","start":"2026-05-08T21:15:09.238396Z","end":"2026-05-08T21:15:11.203021Z","steps":["trace[1394990104] 'agreement among raft nodes before linearized reading' (duration: 1.963990704s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.203209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.238374Z","time spent":"1.964822893s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-08T21:15:11.203205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.686064536s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-08T21:15:11.203256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.939964216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:11.203268Z","caller":"traceutil/trace.go:171","msg":"trace[1662732681] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1299; }","duration":"1.686148388s","start":"2026-05-08T21:15:09.517105Z","end":"2026-05-08T21:15:11.203254Z","steps":["trace[1662732681] 'agreement among raft nodes before linearized reading' (duration: 1.686007445s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:11.203295Z","caller":"traceutil/trace.go:171","msg":"trace[993638436] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1299; }","duration":"1.940032657s","start":"2026-05-08T21:15:09.263254Z","end":"2026-05-08T21:15:11.203286Z","steps":["trace[993638436] 'agreement among raft nodes before linearized reading' (duration: 1.939970846s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.203309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.517094Z","time spent":"1.686204929s","remote":"127.0.0.1:40134","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-05-08T21:15:11.203354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.552753249s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:11.20338Z","caller":"traceutil/trace.go:171","msg":"trace[1812692918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1299; }","duration":"1.55281753s","start":"2026-05-08T21:15:09.650556Z","end":"2026-05-08T21:15:11.203373Z","steps":["trace[1812692918] 'agreement among raft nodes before linearized reading' (duration: 1.552780339s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.203216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.50161933s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-05-08T21:15:11.203371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.532065278s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-05-08T21:15:11.203407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.650536Z","time spent":"1.552864321s","remote":"127.0.0.1:59136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-05-08T21:15:11.203419Z","caller":"traceutil/trace.go:171","msg":"trace[390212655] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1299; }","duration":"1.501860366s","start":"2026-05-08T21:15:09.701545Z","end":"2026-05-08T21:15:11.203406Z","steps":["trace[390212655] 'agreement among raft nodes before linearized reading' (duration: 1.50159377s)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:11.203427Z","caller":"traceutil/trace.go:171","msg":"trace[1409136511] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1299; }","duration":"1.53216521s","start":"2026-05-08T21:15:09.671249Z","end":"2026-05-08T21:15:11.203414Z","steps":["trace[1409136511] 'agreement among raft nodes before linearized reading' (duration: 1.531990566s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.203462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.701522Z","time spent":"1.501928167s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-08T21:15:11.203151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.735095405s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:11.203518Z","caller":"traceutil/trace.go:171","msg":"trace[578975810] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1299; }","duration":"1.735606687s","start":"2026-05-08T21:15:09.467898Z","end":"2026-05-08T21:15:11.203505Z","steps":["trace[578975810] 'agreement among raft nodes before linearized reading' (duration: 1.734990603s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.203322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.26323Z","time spent":"1.940088099s","remote":"127.0.0.1:39894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T21:15:11.203601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.467873Z","time spent":"1.735683749s","remote":"127.0.0.1:40176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:15:11.20347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.671221Z","time spent":"1.532235402s","remote":"127.0.0.1:40406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":140,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:15:11.203719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.705767284s","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-05-08T21:15:11.203836Z","caller":"traceutil/trace.go:171","msg":"trace[1959227464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1299; }","duration":"1.705906016s","start":"2026-05-08T21:15:09.497914Z","end":"2026-05-08T21:15:11.20382Z","steps":["trace[1959227464] 'agreement among raft nodes before linearized reading' (duration: 1.705390665s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.203908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.497901Z","time spent":"1.705998599s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T21:15:11.204818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.966297267s","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-05-08T21:15:11.204872Z","caller":"traceutil/trace.go:171","msg":"trace[1673272273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1299; }","duration":"1.96639493s","start":"2026-05-08T21:15:09.238463Z","end":"2026-05-08T21:15:11.204858Z","steps":["trace[1673272273] 'agreement among raft nodes before linearized reading' (duration: 1.965258143s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:11.204908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:09.238432Z","time spent":"1.966464351s","remote":"127.0.0.1:40134","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-05-08T21:15:11.482823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.812305ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:15:11.482953Z","caller":"traceutil/trace.go:171","msg":"trace[917589035] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"134.740461ms","start":"2026-05-08T21:15:11.348191Z","end":"2026-05-08T21:15:11.482932Z","steps":["trace[917589035] 'process raft request' (duration: 17.738142ms)","trace[917589035] 'compare' (duration: 116.59731ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:12.293168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.341985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:12.293281Z","caller":"traceutil/trace.go:171","msg":"trace[361351809] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:1307; }","duration":"580.483917ms","start":"2026-05-08T21:15:11.712759Z","end":"2026-05-08T21:15:12.293243Z","steps":["trace[361351809] 'range keys from in-memory index tree' (duration: 580.259032ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:12.293356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:11.712736Z","time spent":"580.60532ms","remote":"127.0.0.1:39954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-08T21:15:12.413987Z","caller":"traceutil/trace.go:171","msg":"trace[1185341789] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"272.850831ms","start":"2026-05-08T21:15:12.141115Z","end":"2026-05-08T21:15:12.413966Z","steps":["trace[1185341789] 'read index received' (duration: 272.81195ms)","trace[1185341789] 'applied index is now lower than readState.Index' (duration: 38.06µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:12.414028Z","caller":"traceutil/trace.go:171","msg":"trace[1452354218] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"478.314825ms","start":"2026-05-08T21:15:11.935676Z","end":"2026-05-08T21:15:12.413991Z","steps":["trace[1452354218] 'process raft request' (duration: 478.135031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:12.41414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.999974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:12.414193Z","caller":"traceutil/trace.go:171","msg":"trace[1941606735] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1308; }","duration":"273.101206ms","start":"2026-05-08T21:15:12.14107Z","end":"2026-05-08T21:15:12.414171Z","steps":["trace[1941606735] 'agreement among raft nodes before linearized reading' (duration: 272.996794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:12.414264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:11.935642Z","time spent":"478.511759ms","remote":"127.0.0.1:39948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":780,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T21:15:12.62319Z","caller":"traceutil/trace.go:171","msg":"trace[1336626795] linearizableReadLoop","detail":"{readStateIndex:1362; appliedIndex:1361; }","duration":"209.093689ms","start":"2026-05-08T21:15:12.414046Z","end":"2026-05-08T21:15:12.62314Z","steps":["trace[1336626795] 'read index received' (duration: 171.467974ms)","trace[1336626795] 'applied index is now lower than readState.Index' (duration: 37.623395ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:12.623379Z","caller":"traceutil/trace.go:171","msg":"trace[2050909968] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"327.822338ms","start":"2026-05-08T21:15:12.295518Z","end":"2026-05-08T21:15:12.62334Z","steps":["trace[2050909968] 'process raft request' (duration: 289.987498ms)","trace[2050909968] 'compare' (duration: 37.320158ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:12.62352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:12.2955Z","time spent":"327.95262ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T21:15:12.624144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.745863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:12.624245Z","caller":"traceutil/trace.go:171","msg":"trace[435018150] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1309; }","duration":"360.921677ms","start":"2026-05-08T21:15:12.263301Z","end":"2026-05-08T21:15:12.624223Z","steps":["trace[435018150] 'agreement among raft nodes before linearized reading' (duration: 360.036766ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:12.624294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:12.263279Z","time spent":"361.005299ms","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T21:15:12.638598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.234992ms","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-05-08T21:15:12.638605Z","caller":"traceutil/trace.go:171","msg":"trace[1601213276] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"219.473699ms","start":"2026-05-08T21:15:12.419026Z","end":"2026-05-08T21:15:12.6385Z","steps":["trace[1601213276] 'process raft request' (duration: 219.332316ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:12.638685Z","caller":"traceutil/trace.go:171","msg":"trace[105227017] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:1310; }","duration":"212.340914ms","start":"2026-05-08T21:15:12.426324Z","end":"2026-05-08T21:15:12.638665Z","steps":["trace[105227017] 'agreement among raft nodes before linearized reading' (duration: 212.194201ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:13.052801Z","caller":"traceutil/trace.go:171","msg":"trace[1002031226] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"331.609495ms","start":"2026-05-08T21:15:12.721166Z","end":"2026-05-08T21:15:13.052775Z","steps":["trace[1002031226] 'process raft request' (duration: 331.491262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:13.052943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:12.721139Z","time spent":"331.732988ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:15.819258Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880869267269078565,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T21:15:16.303588Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.018250099s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-08T21:15:17.298895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:16.947676Z","time spent":"351.204251ms","remote":"127.0.0.1:51990","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-08T21:15:17.299642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"995.758058ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:15:17.299752Z","caller":"traceutil/trace.go:171","msg":"trace[1655715021] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1381; }","duration":"1.98099437s","start":"2026-05-08T21:15:15.318739Z","end":"2026-05-08T21:15:17.299733Z","steps":["trace[1655715021] 'read index received' (duration: 984.977036ms)","trace[1655715021] 'applied index is now lower than readState.Index' (duration: 996.016034ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:17.29981Z","caller":"traceutil/trace.go:171","msg":"trace[1428162998] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"2.014548429s","start":"2026-05-08T21:15:15.285233Z","end":"2026-05-08T21:15:17.299781Z","steps":["trace[1428162998] 'process raft request' (duration: 1.018543875s)","trace[1428162998] 'compare' (duration: 995.505072ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:17.299947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:15.285212Z","time spent":"2.014661582s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:17.300064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.981262016s","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-05-08T21:15:17.300125Z","caller":"traceutil/trace.go:171","msg":"trace[1224524426] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1328; }","duration":"1.981428879s","start":"2026-05-08T21:15:15.318682Z","end":"2026-05-08T21:15:17.300111Z","steps":["trace[1224524426] 'agreement among raft nodes before linearized reading' (duration: 1.981131313s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.300161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:15.318659Z","time spent":"1.98149415s","remote":"127.0.0.1:40134","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-05-08T21:15:17.719308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.718865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T21:15:17.719586Z","caller":"traceutil/trace.go:171","msg":"trace[1378390649] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"477.70656ms","start":"2026-05-08T21:15:17.241854Z","end":"2026-05-08T21:15:17.719561Z","steps":["trace[1378390649] 'process raft request' (duration: 359.645847ms)","trace[1378390649] 'compare' (duration: 116.975788ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:17.719947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.396912164s","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-05-08T21:15:17.720025Z","caller":"traceutil/trace.go:171","msg":"trace[1754773085] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1329; }","duration":"2.397020717s","start":"2026-05-08T21:15:15.322986Z","end":"2026-05-08T21:15:17.720007Z","steps":["trace[1754773085] 'agreement among raft nodes before linearized reading' (duration: 2.396804962s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.720029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784618168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-08T21:15:17.720066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:15.322978Z","time spent":"2.397080148s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-08T21:15:17.71965Z","caller":"traceutil/trace.go:171","msg":"trace[603490931] linearizableReadLoop","detail":"{readStateIndex:1383; appliedIndex:1382; }","duration":"419.843006ms","start":"2026-05-08T21:15:17.299789Z","end":"2026-05-08T21:15:17.719632Z","steps":["trace[603490931] 'read index received' (duration: 301.841254ms)","trace[603490931] 'applied index is now lower than readState.Index' (duration: 118.000082ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:17.720113Z","caller":"traceutil/trace.go:171","msg":"trace[1644152279] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1329; }","duration":"1.784770371s","start":"2026-05-08T21:15:15.935323Z","end":"2026-05-08T21:15:17.720094Z","steps":["trace[1644152279] 'agreement among raft nodes before linearized reading' (duration: 1.784584736s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.720182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:15.935302Z","time spent":"1.784868884s","remote":"127.0.0.1:40264","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:15:17.719708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.456018403s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:17.720268Z","caller":"traceutil/trace.go:171","msg":"trace[1489562363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1329; }","duration":"1.456627027s","start":"2026-05-08T21:15:16.263622Z","end":"2026-05-08T21:15:17.720249Z","steps":["trace[1489562363] 'agreement among raft nodes before linearized reading' (duration: 1.456013953s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.720348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:16.263601Z","time spent":"1.456711949s","remote":"127.0.0.1:39884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-08T21:15:17.720355Z","caller":"traceutil/trace.go:171","msg":"trace[1755683581] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"415.591577ms","start":"2026-05-08T21:15:17.304721Z","end":"2026-05-08T21:15:17.720312Z","steps":["trace[1755683581] 'process raft request' (duration: 414.682236ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.719757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.953099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:15:17.720422Z","caller":"traceutil/trace.go:171","msg":"trace[1565405354] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1329; }","duration":"624.680246ms","start":"2026-05-08T21:15:17.095728Z","end":"2026-05-08T21:15:17.720408Z","steps":["trace[1565405354] 'agreement among raft nodes before linearized reading' (duration: 623.935159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.720428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:17.304702Z","time spent":"415.68839ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:17.720464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:17.095702Z","time spent":"624.747637ms","remote":"127.0.0.1:40286","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:15:17.719848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.397304343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T21:15:17.720598Z","caller":"traceutil/trace.go:171","msg":"trace[1101432468] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"320.209881ms","start":"2026-05-08T21:15:17.400366Z","end":"2026-05-08T21:15:17.720576Z","steps":["trace[1101432468] 'process raft request' (duration: 319.824822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.720704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:17.400342Z","time spent":"320.300692ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:15:17.720613Z","caller":"traceutil/trace.go:171","msg":"trace[1097781957] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1329; }","duration":"2.398112072s","start":"2026-05-08T21:15:15.32249Z","end":"2026-05-08T21:15:17.720602Z","steps":["trace[1097781957] 'agreement among raft nodes before linearized reading' (duration: 2.39718948s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.720765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:15.322468Z","time spent":"2.398286176s","remote":"127.0.0.1:40134","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-05-08T21:15:17.719868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.409994073s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-08T21:15:17.720844Z","caller":"traceutil/trace.go:171","msg":"trace[248285276] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1329; }","duration":"1.410995907s","start":"2026-05-08T21:15:16.309835Z","end":"2026-05-08T21:15:17.720831Z","steps":["trace[248285276] 'agreement among raft nodes before linearized reading' (duration: 1.409918912s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.720847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:17.241829Z","time spent":"478.159611ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:15:17.72089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:16.309818Z","time spent":"1.411055858s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-08T21:15:17.719925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.397323284s","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-05-08T21:15:17.720972Z","caller":"traceutil/trace.go:171","msg":"trace[1285649041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1329; }","duration":"2.398409279s","start":"2026-05-08T21:15:15.322555Z","end":"2026-05-08T21:15:17.720964Z","steps":["trace[1285649041] 'agreement among raft nodes before linearized reading' (duration: 2.397315094s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.721005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:15.322529Z","time spent":"2.39846991s","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T21:15:17.719865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.314771ms","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-05-08T21:15:17.721079Z","caller":"traceutil/trace.go:171","msg":"trace[293394850] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1329; }","duration":"441.56653ms","start":"2026-05-08T21:15:17.279495Z","end":"2026-05-08T21:15:17.721062Z","steps":["trace[293394850] 'agreement among raft nodes before linearized reading' (duration: 440.344882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:17.721133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:15:17.279475Z","time spent":"441.640062ms","remote":"127.0.0.1:58968","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-05-08T21:15:31.997233Z","caller":"traceutil/trace.go:171","msg":"trace[796664324] linearizableReadLoop","detail":"{readStateIndex:1469; appliedIndex:1468; }","duration":"181.903616ms","start":"2026-05-08T21:15:31.815304Z","end":"2026-05-08T21:15:31.997207Z","steps":["trace[796664324] 'read index received' (duration: 126.56587ms)","trace[796664324] 'applied index is now lower than readState.Index' (duration: 55.336436ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:31.99741Z","caller":"traceutil/trace.go:171","msg":"trace[314785907] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"188.617582ms","start":"2026-05-08T21:15:31.808773Z","end":"2026-05-08T21:15:31.99739Z","steps":["trace[314785907] 'process raft request' (duration: 133.159354ms)","trace[314785907] 'compare' (duration: 55.163341ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:15:31.997484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.98476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-08T21:15:31.997563Z","caller":"traceutil/trace.go:171","msg":"trace[1307939826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1412; }","duration":"173.105063ms","start":"2026-05-08T21:15:31.824438Z","end":"2026-05-08T21:15:31.997543Z","steps":["trace[1307939826] 'agreement among raft nodes before linearized reading' (duration: 172.924089ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:31.997818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.484522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-08T21:15:31.997858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.538861ms","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-05-08T21:15:31.99796Z","caller":"traceutil/trace.go:171","msg":"trace[1750051823] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1412; }","duration":"182.684815ms","start":"2026-05-08T21:15:31.815257Z","end":"2026-05-08T21:15:31.997942Z","steps":["trace[1750051823] 'agreement among raft nodes before linearized reading' (duration: 182.419199ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:31.997875Z","caller":"traceutil/trace.go:171","msg":"trace[1488203926] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1412; }","duration":"170.573503ms","start":"2026-05-08T21:15:31.827287Z","end":"2026-05-08T21:15:31.997861Z","steps":["trace[1488203926] 'agreement among raft nodes before linearized reading' (duration: 170.392869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:31.997972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.347098ms","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-05-08T21:15:31.998226Z","caller":"traceutil/trace.go:171","msg":"trace[1965399890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1412; }","duration":"170.612704ms","start":"2026-05-08T21:15:31.827597Z","end":"2026-05-08T21:15:31.998209Z","steps":["trace[1965399890] 'agreement among raft nodes before linearized reading' (duration: 170.01055ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:52.288853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.554809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-08T21:15:52.288853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.678513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-08T21:15:52.288864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.489872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-05-08T21:15:52.288934Z","caller":"traceutil/trace.go:171","msg":"trace[785114624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1505; }","duration":"129.848387ms","start":"2026-05-08T21:15:52.159071Z","end":"2026-05-08T21:15:52.28892Z","steps":["trace[785114624] 'range keys from in-memory index tree' (duration: 129.362516ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:52.288927Z","caller":"traceutil/trace.go:171","msg":"trace[1872078213] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1505; }","duration":"138.696622ms","start":"2026-05-08T21:15:52.150213Z","end":"2026-05-08T21:15:52.28891Z","steps":["trace[1872078213] 'range keys from in-memory index tree' (duration: 138.393835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:52.288934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.019234ms","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-05-08T21:15:52.289084Z","caller":"traceutil/trace.go:171","msg":"trace[1123039316] transaction","detail":"{read_only:false; response_revision:1506; number_of_response:1; }","duration":"127.486172ms","start":"2026-05-08T21:15:52.161569Z","end":"2026-05-08T21:15:52.289055Z","steps":["trace[1123039316] 'process raft request' (duration: 127.061512ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:52.289102Z","caller":"traceutil/trace.go:171","msg":"trace[2072092080] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1505; }","duration":"134.214929ms","start":"2026-05-08T21:15:52.154877Z","end":"2026-05-08T21:15:52.289092Z","steps":["trace[2072092080] 'range keys from in-memory index tree' (duration: 133.887941ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:52.288997Z","caller":"traceutil/trace.go:171","msg":"trace[1691838508] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1505; }","duration":"130.712777ms","start":"2026-05-08T21:15:52.158251Z","end":"2026-05-08T21:15:52.288963Z","steps":["trace[1691838508] 'range keys from in-memory index tree' (duration: 130.253897ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:15:59.68907Z","caller":"traceutil/trace.go:171","msg":"trace[265260568] linearizableReadLoop","detail":"{readStateIndex:1604; appliedIndex:1603; }","duration":"134.94138ms","start":"2026-05-08T21:15:59.554105Z","end":"2026-05-08T21:15:59.689046Z","steps":["trace[265260568] 'read index received' (duration: 134.679244ms)","trace[265260568] 'applied index is now lower than readState.Index' (duration: 261.106µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:15:59.689102Z","caller":"traceutil/trace.go:171","msg":"trace[1640485993] transaction","detail":"{read_only:false; response_revision:1541; number_of_response:1; }","duration":"188.656934ms","start":"2026-05-08T21:15:59.500424Z","end":"2026-05-08T21:15:59.689081Z","steps":["trace[1640485993] 'process raft request' (duration: 188.437898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:15:59.689369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.232426ms","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-05-08T21:15:59.689459Z","caller":"traceutil/trace.go:171","msg":"trace[1688832602] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1541; }","duration":"135.38126ms","start":"2026-05-08T21:15:59.554056Z","end":"2026-05-08T21:15:59.689437Z","steps":["trace[1688832602] 'agreement among raft nodes before linearized reading' (duration: 135.105753ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:00.511797Z","caller":"traceutil/trace.go:171","msg":"trace[1155788866] transaction","detail":"{read_only:false; response_revision:1548; number_of_response:1; }","duration":"105.466712ms","start":"2026-05-08T21:16:00.406307Z","end":"2026-05-08T21:16:00.511774Z","steps":["trace[1155788866] 'process raft request' (duration: 105.424431ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:16:00.512073Z","caller":"traceutil/trace.go:171","msg":"trace[798057219] transaction","detail":"{read_only:false; response_revision:1547; number_of_response:1; }","duration":"106.327142ms","start":"2026-05-08T21:16:00.405694Z","end":"2026-05-08T21:16:00.512021Z","steps":["trace[798057219] 'process raft request' (duration: 105.870261ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:19.06465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.656081ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-05-08T21:16:19.064793Z","caller":"traceutil/trace.go:171","msg":"trace[1602505826] linearizableReadLoop","detail":"{readStateIndex:1698; appliedIndex:1697; }","duration":"327.128135ms","start":"2026-05-08T21:16:18.737611Z","end":"2026-05-08T21:16:19.064739Z","steps":["trace[1602505826] 'read index received' (duration: 37.265689ms)","trace[1602505826] 'applied index is now lower than readState.Index' (duration: 289.860946ms)"],"step_count":2} {"level":"warn","ts":"2026-05-08T21:16:19.065026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.394581ms","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-05-08T21:16:19.065115Z","caller":"traceutil/trace.go:171","msg":"trace[945415663] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1631; }","duration":"327.509225ms","start":"2026-05-08T21:16:18.737594Z","end":"2026-05-08T21:16:19.065104Z","steps":["trace[945415663] 'agreement among raft nodes before linearized reading' (duration: 327.265999ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:16:19.06541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:16:18.737585Z","time spent":"327.807931ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T21:16:19.241192Z","caller":"traceutil/trace.go:171","msg":"trace[998004586] transaction","detail":"{read_only:false; response_revision:1632; number_of_response:1; }","duration":"171.532183ms","start":"2026-05-08T21:16:19.069633Z","end":"2026-05-08T21:16:19.241165Z","steps":["trace[998004586] 'process raft request' (duration: 171.266697ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:17:41.121594Z","caller":"traceutil/trace.go:171","msg":"trace[346322538] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"114.566702ms","start":"2026-05-08T21:17:41.007002Z","end":"2026-05-08T21:17:41.121569Z","steps":["trace[346322538] 'process raft request' (duration: 114.399928ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T21:18:25.865424Z","caller":"traceutil/trace.go:171","msg":"trace[1771018675] transaction","detail":"{read_only:false; response_revision:2233; number_of_response:1; }","duration":"518.030353ms","start":"2026-05-08T21:18:25.347356Z","end":"2026-05-08T21:18:25.865386Z","steps":["trace[1771018675] 'process raft request' (duration: 517.806438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:18:25.865832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:18:25.347331Z","time spent":"518.34493ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T21:18:25.876632Z","caller":"traceutil/trace.go:171","msg":"trace[246979155] linearizableReadLoop","detail":"{readStateIndex:2327; appliedIndex:2325; }","duration":"430.418693ms","start":"2026-05-08T21:18:25.446199Z","end":"2026-05-08T21:18:25.876617Z","steps":["trace[246979155] 'read index received' (duration: 418.907234ms)","trace[246979155] 'applied index is now lower than readState.Index' (duration: 11.510299ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:18:25.876749Z","caller":"traceutil/trace.go:171","msg":"trace[2030403676] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"479.273396ms","start":"2026-05-08T21:18:25.397467Z","end":"2026-05-08T21:18:25.87674Z","steps":["trace[2030403676] 'process raft request' (duration: 478.974319ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:18:25.876851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:18:25.397444Z","time spent":"479.375468ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T21:18:25.877019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.827214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-08T21:18:25.877074Z","caller":"traceutil/trace.go:171","msg":"trace[1795638050] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2234; }","duration":"430.921316ms","start":"2026-05-08T21:18:25.446144Z","end":"2026-05-08T21:18:25.877066Z","steps":["trace[1795638050] 'agreement among raft nodes before linearized reading' (duration: 430.782963ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:18:25.877112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:18:25.446122Z","time spent":"430.983837ms","remote":"127.0.0.1:40134","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-05-08T21:18:25.877299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.347544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:18:25.877351Z","caller":"traceutil/trace.go:171","msg":"trace[1459647911] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:2234; }","duration":"404.442746ms","start":"2026-05-08T21:18:25.472898Z","end":"2026-05-08T21:18:25.877341Z","steps":["trace[1459647911] 'agreement among raft nodes before linearized reading' (duration: 404.371815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:18:25.877432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:18:25.472879Z","time spent":"404.543989ms","remote":"127.0.0.1:59106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-08T21:18:25.877638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.925332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T21:18:25.877694Z","caller":"traceutil/trace.go:171","msg":"trace[1002143764] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2234; }","duration":"297.017764ms","start":"2026-05-08T21:18:25.580666Z","end":"2026-05-08T21:18:25.877684Z","steps":["trace[1002143764] 'agreement among raft nodes before linearized reading' (duration: 296.944933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:18:25.877928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.620376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-05-08T21:18:25.877986Z","caller":"traceutil/trace.go:171","msg":"trace[808341068] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2234; }","duration":"382.700898ms","start":"2026-05-08T21:18:25.495277Z","end":"2026-05-08T21:18:25.877978Z","steps":["trace[808341068] 'agreement among raft nodes before linearized reading' (duration: 382.598186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:18:25.878062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T21:18:25.495267Z","time spent":"382.78868ms","remote":"127.0.0.1:40134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-08T21:18:31.221226Z","caller":"traceutil/trace.go:171","msg":"trace[341074358] linearizableReadLoop","detail":"{readStateIndex:2358; appliedIndex:2357; }","duration":"119.628247ms","start":"2026-05-08T21:18:31.10157Z","end":"2026-05-08T21:18:31.221198Z","steps":["trace[341074358] 'read index received' (duration: 119.396741ms)","trace[341074358] 'applied index is now lower than readState.Index' (duration: 230.426µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T21:18:31.22135Z","caller":"traceutil/trace.go:171","msg":"trace[845849780] transaction","detail":"{read_only:false; response_revision:2264; number_of_response:1; }","duration":"251.947321ms","start":"2026-05-08T21:18:30.969376Z","end":"2026-05-08T21:18:31.221323Z","steps":["trace[845849780] 'process raft request' (duration: 251.662244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T21:18:31.221449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.846303ms","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-05-08T21:18:31.221701Z","caller":"traceutil/trace.go:171","msg":"trace[864041887] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2264; }","duration":"120.145469ms","start":"2026-05-08T21:18:31.101523Z","end":"2026-05-08T21:18:31.221669Z","steps":["trace[864041887] 'agreement among raft nodes before linearized reading' (duration: 119.825061ms)"],"step_count":1}