{"level":"warn","ts":"2026-04-08T00:35:24.287205Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T00:35:24.287294Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38: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.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-08T00:35:24.287377Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-08T00:35:24.287391Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-08T00:35:24.287412Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T00:35:24.288096Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-04-08T00:35:24.288179Z","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":16,"max-cpu-available":16,"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.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-08T00:35:24.291993Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.583699ms"} {"level":"info","ts":"2026-04-08T00:35:24.29999Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-04-08T00:35:24.300074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-04-08T00:35:24.300098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-04-08T00:35:24.30012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-08T00:35:24.300136Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-04-08T00:35:24.300189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-04-08T00:35:24.305983Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-08T00:35:24.30734Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-08T00:35:24.308509Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-08T00:35:24.31228Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-08T00:35:24.313063Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-08T00:35:24.313062Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T00:35:24.313167Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T00:35:24.313209Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-08T00:35:24.315009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-04-08T00:35:24.3152Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-04-08T00:35:24.32092Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-08T00:35:24.321001Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-08T00:35:24.321047Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-04-08T00:35:24.32133Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-08T00:35:24.321377Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-08T00:35:24.40059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-04-08T00:35:24.400654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-08T00:35:24.400671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-04-08T00:35:24.400686Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-04-08T00:35:24.400694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-08T00:35:24.400706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-04-08T00:35:24.40072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-04-08T00:35:24.401558Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T00:35:24.402306Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T00:35:24.402315Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-04-08T00:35:24.402404Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-08T00:35:24.402615Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-08T00:35:24.402652Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-08T00:35:24.402932Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T00:35:24.403036Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T00:35:24.403069Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-08T00:35:24.40429Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-04-08T00:35:24.405468Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-08T00:35:34.82731Z","caller":"traceutil/trace.go:171","msg":"trace[1203977984] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"182.768676ms","start":"2026-04-08T00:35:34.644515Z","end":"2026-04-08T00:35:34.827284Z","steps":["trace[1203977984] 'process raft request' (duration: 182.546441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:35:34.827451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.062088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-08T00:35:34.827676Z","caller":"traceutil/trace.go:171","msg":"trace[746091664] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:342; }","duration":"142.343335ms","start":"2026-04-08T00:35:34.685316Z","end":"2026-04-08T00:35:34.82766Z","steps":["trace[746091664] 'agreement among raft nodes before linearized reading' (duration: 142.053728ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:35:34.827251Z","caller":"traceutil/trace.go:171","msg":"trace[1967673379] linearizableReadLoop","detail":"{readStateIndex:356; appliedIndex:355; }","duration":"141.870874ms","start":"2026-04-08T00:35:34.685356Z","end":"2026-04-08T00:35:34.827227Z","steps":["trace[1967673379] 'read index received' (duration: 141.65332ms)","trace[1967673379] 'applied index is now lower than readState.Index' (duration: 216.624µs)"],"step_count":2} {"level":"warn","ts":"2026-04-08T00:35:35.158959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.751584ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-08T00:35:35.159511Z","caller":"traceutil/trace.go:171","msg":"trace[1630347783] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"322.319539ms","start":"2026-04-08T00:35:34.837123Z","end":"2026-04-08T00:35:35.159443Z","steps":["trace[1630347783] 'process raft request' (duration: 322.103454ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:35:35.159635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:35:34.8371Z","time spent":"322.445782ms","remote":"127.0.0.1:59094","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-08T00:35:35.160004Z","caller":"traceutil/trace.go:171","msg":"trace[526684193] transaction","detail":"{read_only:false; response_revision:343; number_of_response:1; }","duration":"326.691106ms","start":"2026-04-08T00:35:34.833289Z","end":"2026-04-08T00:35:35.15998Z","steps":["trace[526684193] 'process raft request' (duration: 97.520538ms)","trace[526684193] 'compare' (duration: 226.53763ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:35:35.160106Z","caller":"traceutil/trace.go:171","msg":"trace[320740584] linearizableReadLoop","detail":"{readStateIndex:357; appliedIndex:356; }","duration":"324.446856ms","start":"2026-04-08T00:35:34.835594Z","end":"2026-04-08T00:35:35.160041Z","steps":["trace[320740584] 'read index received' (duration: 95.241757ms)","trace[320740584] 'applied index is now lower than readState.Index' (duration: 229.203579ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T00:35:35.16025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:35:34.833261Z","time spent":"326.764648ms","remote":"127.0.0.1:58616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":654,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-08T00:35:35.161541Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.629473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"warn","ts":"2026-04-08T00:35:35.161565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.185412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"warn","ts":"2026-04-08T00:35:35.16169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.958276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-04-08T00:35:35.161682Z","caller":"traceutil/trace.go:171","msg":"trace[427966417] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:344; }","duration":"127.340226ms","start":"2026-04-08T00:35:35.034305Z","end":"2026-04-08T00:35:35.161645Z","steps":["trace[427966417] 'agreement among raft nodes before linearized reading' (duration: 126.963606ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:35:35.161729Z","caller":"traceutil/trace.go:171","msg":"trace[172071999] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:344; }","duration":"176.055268ms","start":"2026-04-08T00:35:34.98566Z","end":"2026-04-08T00:35:35.161716Z","steps":["trace[172071999] 'agreement among raft nodes before linearized reading' (duration: 175.974426ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:35:35.161607Z","caller":"traceutil/trace.go:171","msg":"trace[121505225] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:344; }","duration":"276.746566ms","start":"2026-04-08T00:35:34.884826Z","end":"2026-04-08T00:35:35.161573Z","steps":["trace[121505225] 'agreement among raft nodes before linearized reading' (duration: 276.303405ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:35:35.162021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.43032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-04-08T00:35:35.161996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.368828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"warn","ts":"2026-04-08T00:35:35.162091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.034624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-08T00:35:35.162154Z","caller":"traceutil/trace.go:171","msg":"trace[1381907798] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:344; }","duration":"227.577732ms","start":"2026-04-08T00:35:34.934544Z","end":"2026-04-08T00:35:35.162122Z","steps":["trace[1381907798] 'agreement among raft nodes before linearized reading' (duration: 227.269185ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:35:35.162191Z","caller":"traceutil/trace.go:171","msg":"trace[888889057] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:344; }","duration":"263.161657ms","start":"2026-04-08T00:35:34.898994Z","end":"2026-04-08T00:35:35.162156Z","steps":["trace[888889057] 'agreement among raft nodes before linearized reading' (duration: 263.018494ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:35:35.162093Z","caller":"traceutil/trace.go:171","msg":"trace[220720480] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:344; }","duration":"326.563513ms","start":"2026-04-08T00:35:34.835494Z","end":"2026-04-08T00:35:35.162058Z","steps":["trace[220720480] 'agreement among raft nodes before linearized reading' (duration: 324.865735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:35:35.162309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:35:34.835434Z","time spent":"326.833239ms","remote":"127.0.0.1:58760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":231,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-04-08T00:35:57.562831Z","caller":"traceutil/trace.go:171","msg":"trace[368027296] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"143.988571ms","start":"2026-04-08T00:35:57.418812Z","end":"2026-04-08T00:35:57.5628Z","steps":["trace[368027296] 'process raft request' (duration: 143.038691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:35:57.563159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.120642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T00:35:57.563246Z","caller":"traceutil/trace.go:171","msg":"trace[49178843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"143.266056ms","start":"2026-04-08T00:35:57.419966Z","end":"2026-04-08T00:35:57.563232Z","steps":["trace[49178843] 'agreement among raft nodes before linearized reading' (duration: 142.9986ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:35:57.562845Z","caller":"traceutil/trace.go:171","msg":"trace[1895343846] linearizableReadLoop","detail":"{readStateIndex:596; appliedIndex:595; }","duration":"142.803496ms","start":"2026-04-08T00:35:57.420012Z","end":"2026-04-08T00:35:57.562816Z","steps":["trace[1895343846] 'read index received' (duration: 141.912227ms)","trace[1895343846] 'applied index is now lower than readState.Index' (duration: 889.939µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:35:57.566211Z","caller":"traceutil/trace.go:171","msg":"trace[19877312] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"139.941542ms","start":"2026-04-08T00:35:57.426244Z","end":"2026-04-08T00:35:57.566185Z","steps":["trace[19877312] 'process raft request' (duration: 139.702097ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:35:57.566565Z","caller":"traceutil/trace.go:171","msg":"trace[1683226453] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"132.998069ms","start":"2026-04-08T00:35:57.433547Z","end":"2026-04-08T00:35:57.566545Z","steps":["trace[1683226453] 'process raft request' (duration: 132.516228ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:03.670322Z","caller":"traceutil/trace.go:171","msg":"trace[769111601] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"110.021973ms","start":"2026-04-08T00:36:03.56026Z","end":"2026-04-08T00:36:03.670282Z","steps":["trace[769111601] 'process raft request' (duration: 101.312532ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:03.670393Z","caller":"traceutil/trace.go:171","msg":"trace[1463906181] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"107.526958ms","start":"2026-04-08T00:36:03.562842Z","end":"2026-04-08T00:36:03.670369Z","steps":["trace[1463906181] 'process raft request' (duration: 107.432566ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:03.670469Z","caller":"traceutil/trace.go:171","msg":"trace[911910776] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"109.290448ms","start":"2026-04-08T00:36:03.561139Z","end":"2026-04-08T00:36:03.670429Z","steps":["trace[911910776] 'process raft request' (duration: 109.060893ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:04.69823Z","caller":"traceutil/trace.go:171","msg":"trace[1465784207] linearizableReadLoop","detail":"{readStateIndex:661; appliedIndex:660; }","duration":"293.519046ms","start":"2026-04-08T00:36:04.404653Z","end":"2026-04-08T00:36:04.698172Z","steps":["trace[1465784207] 'read index received' (duration: 293.291031ms)","trace[1465784207] 'applied index is now lower than readState.Index' (duration: 226.904µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:36:04.698322Z","caller":"traceutil/trace.go:171","msg":"trace[1557715035] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"328.209249ms","start":"2026-04-08T00:36:04.370071Z","end":"2026-04-08T00:36:04.698281Z","steps":["trace[1557715035] 'process raft request' (duration: 327.934403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.69839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.705489ms","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":"warn","ts":"2026-04-08T00:36:04.698548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.132679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.69859Z","caller":"traceutil/trace.go:171","msg":"trace[197387656] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:636; }","duration":"186.19283ms","start":"2026-04-08T00:36:04.512386Z","end":"2026-04-08T00:36:04.698578Z","steps":["trace[197387656] 'agreement among raft nodes before linearized reading' (duration: 186.139419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.624219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.698649Z","caller":"traceutil/trace.go:171","msg":"trace[1729820304] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:636; }","duration":"185.748031ms","start":"2026-04-08T00:36:04.512884Z","end":"2026-04-08T00:36:04.698632Z","steps":["trace[1729820304] 'agreement among raft nodes before linearized reading' (duration: 185.624669ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.971094ms","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":"warn","ts":"2026-04-08T00:36:04.69869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:36:04.370053Z","time spent":"328.342742ms","remote":"127.0.0.1:58840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T00:36:04.698738Z","caller":"traceutil/trace.go:171","msg":"trace[420350734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:636; }","duration":"215.093617ms","start":"2026-04-08T00:36:04.483623Z","end":"2026-04-08T00:36:04.698717Z","steps":["trace[420350734] 'agreement among raft nodes before linearized reading' (duration: 214.921114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.875048ms","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":"warn","ts":"2026-04-08T00:36:04.699123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.834545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.699223Z","caller":"traceutil/trace.go:171","msg":"trace[359705833] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:636; }","duration":"240.981528ms","start":"2026-04-08T00:36:04.458218Z","end":"2026-04-08T00:36:04.6992Z","steps":["trace[359705833] 'agreement among raft nodes before linearized reading' (duration: 240.735751ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.144506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.699293Z","caller":"traceutil/trace.go:171","msg":"trace[481369613] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"130.798031ms","start":"2026-04-08T00:36:04.568469Z","end":"2026-04-08T00:36:04.699267Z","steps":["trace[481369613] 'agreement among raft nodes before linearized reading' (duration: 130.123126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.362261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.699324Z","caller":"traceutil/trace.go:171","msg":"trace[1427369618] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"104.194386ms","start":"2026-04-08T00:36:04.594857Z","end":"2026-04-08T00:36:04.699051Z","steps":["trace[1427369618] 'agreement among raft nodes before linearized reading' (duration: 103.869008ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.264435ms","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-04-08T00:36:04.699518Z","caller":"traceutil/trace.go:171","msg":"trace[821400804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"131.036857ms","start":"2026-04-08T00:36:04.56839Z","end":"2026-04-08T00:36:04.699427Z","steps":["trace[821400804] 'agreement among raft nodes before linearized reading' (duration: 130.372871ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:04.69959Z","caller":"traceutil/trace.go:171","msg":"trace[189394548] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"104.343059ms","start":"2026-04-08T00:36:04.595223Z","end":"2026-04-08T00:36:04.699566Z","steps":["trace[189394548] 'agreement among raft nodes before linearized reading' (duration: 103.262204ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.515778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.699736Z","caller":"traceutil/trace.go:171","msg":"trace[971330748] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:636; }","duration":"187.363947ms","start":"2026-04-08T00:36:04.512328Z","end":"2026-04-08T00:36:04.699692Z","steps":["trace[971330748] 'agreement among raft nodes before linearized reading' (duration: 186.525948ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:04.698866Z","caller":"traceutil/trace.go:171","msg":"trace[1431647446] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:636; }","duration":"293.885613ms","start":"2026-04-08T00:36:04.404648Z","end":"2026-04-08T00:36:04.698534Z","steps":["trace[1431647446] 'agreement among raft nodes before linearized reading' (duration: 293.661248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.663378ms","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-04-08T00:36:04.699899Z","caller":"traceutil/trace.go:171","msg":"trace[1200980804] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:636; }","duration":"295.173043ms","start":"2026-04-08T00:36:04.404717Z","end":"2026-04-08T00:36:04.69989Z","steps":["trace[1200980804] 'agreement among raft nodes before linearized reading' (duration: 293.653939ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.199627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.699992Z","caller":"traceutil/trace.go:171","msg":"trace[1132224869] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:636; }","duration":"215.363963ms","start":"2026-04-08T00:36:04.484597Z","end":"2026-04-08T00:36:04.699961Z","steps":["trace[1132224869] 'agreement among raft nodes before linearized reading' (duration: 214.197767ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.489949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700074Z","caller":"traceutil/trace.go:171","msg":"trace[228696814] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:636; }","duration":"163.675456ms","start":"2026-04-08T00:36:04.536389Z","end":"2026-04-08T00:36:04.700064Z","steps":["trace[228696814] 'agreement among raft nodes before linearized reading' (duration: 162.449648ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698924Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.7614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700178Z","caller":"traceutil/trace.go:171","msg":"trace[262278556] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:636; }","duration":"295.034649ms","start":"2026-04-08T00:36:04.405126Z","end":"2026-04-08T00:36:04.700161Z","steps":["trace[262278556] 'agreement among raft nodes before linearized reading' (duration: 293.77897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.088152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700268Z","caller":"traceutil/trace.go:171","msg":"trace[972497273] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:636; }","duration":"105.415412ms","start":"2026-04-08T00:36:04.594846Z","end":"2026-04-08T00:36:04.700261Z","steps":["trace[972497273] 'agreement among raft nodes before linearized reading' (duration: 104.074282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.949294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700317Z","caller":"traceutil/trace.go:171","msg":"trace[1175642955] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:636; }","duration":"112.294224ms","start":"2026-04-08T00:36:04.588Z","end":"2026-04-08T00:36:04.700295Z","steps":["trace[1175642955] 'agreement among raft nodes before linearized reading' (duration: 110.948733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.480839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700595Z","caller":"traceutil/trace.go:171","msg":"trace[1138143682] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:636; }","duration":"164.190707ms","start":"2026-04-08T00:36:04.536392Z","end":"2026-04-08T00:36:04.700583Z","steps":["trace[1138143682] 'agreement among raft nodes before linearized reading' (duration: 162.430078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.734032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700737Z","caller":"traceutil/trace.go:171","msg":"trace[1737679489] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:636; }","duration":"242.491211ms","start":"2026-04-08T00:36:04.458234Z","end":"2026-04-08T00:36:04.700725Z","steps":["trace[1737679489] 'agreement among raft nodes before linearized reading' (duration: 240.716891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.69898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.23061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700816Z","caller":"traceutil/trace.go:171","msg":"trace[1030627902] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:636; }","duration":"217.105091ms","start":"2026-04-08T00:36:04.483689Z","end":"2026-04-08T00:36:04.700794Z","steps":["trace[1030627902] 'agreement among raft nodes before linearized reading' (duration: 215.24496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.698969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.697321ms","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-04-08T00:36:04.700873Z","caller":"traceutil/trace.go:171","msg":"trace[706926951] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:636; }","duration":"242.666535ms","start":"2026-04-08T00:36:04.458197Z","end":"2026-04-08T00:36:04.700863Z","steps":["trace[706926951] 'agreement among raft nodes before linearized reading' (duration: 240.670541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:04.69883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.862225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:04.700933Z","caller":"traceutil/trace.go:171","msg":"trace[453147782] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:636; }","duration":"163.968431ms","start":"2026-04-08T00:36:04.53695Z","end":"2026-04-08T00:36:04.700919Z","steps":["trace[453147782] 'agreement among raft nodes before linearized reading' (duration: 161.861974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:05.979678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.731729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:05.979826Z","caller":"traceutil/trace.go:171","msg":"trace[247395164] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:651; }","duration":"110.916563ms","start":"2026-04-08T00:36:05.868864Z","end":"2026-04-08T00:36:05.979781Z","steps":["trace[247395164] 'range keys from in-memory index tree' (duration: 110.622897ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:05.979682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.700458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:36:05.979952Z","caller":"traceutil/trace.go:171","msg":"trace[1388732657] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:651; }","duration":"110.999245ms","start":"2026-04-08T00:36:05.868931Z","end":"2026-04-08T00:36:05.97993Z","steps":["trace[1388732657] 'range keys from in-memory index tree' (duration: 110.661308ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:05.982545Z","caller":"traceutil/trace.go:171","msg":"trace[329162308] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"112.978078ms","start":"2026-04-08T00:36:05.86955Z","end":"2026-04-08T00:36:05.982528Z","steps":["trace[329162308] 'process raft request' (duration: 112.870896ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:05.989075Z","caller":"traceutil/trace.go:171","msg":"trace[847103406] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"118.824966ms","start":"2026-04-08T00:36:05.870232Z","end":"2026-04-08T00:36:05.989057Z","steps":["trace[847103406] 'process raft request' (duration: 118.764974ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:36:05.989138Z","caller":"traceutil/trace.go:171","msg":"trace[1835163483] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"119.357369ms","start":"2026-04-08T00:36:05.86976Z","end":"2026-04-08T00:36:05.989117Z","steps":["trace[1835163483] 'process raft request' (duration: 119.142924ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:19.988206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.396104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8pkgt\" ","response":"range_response_count:1 size:18709"} {"level":"info","ts":"2026-04-08T00:36:19.988281Z","caller":"traceutil/trace.go:171","msg":"trace[1819992801] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8pkgt; range_end:; response_count:1; response_revision:785; }","duration":"232.575328ms","start":"2026-04-08T00:36:19.755688Z","end":"2026-04-08T00:36:19.988264Z","steps":["trace[1819992801] 'range keys from in-memory index tree' (duration: 232.23602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:36:19.98834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.988206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T00:36:19.988427Z","caller":"traceutil/trace.go:171","msg":"trace[94237138] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:785; }","duration":"232.084028ms","start":"2026-04-08T00:36:19.75632Z","end":"2026-04-08T00:36:19.988404Z","steps":["trace[94237138] 'range keys from in-memory index tree' (duration: 231.866292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:37:36.56316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.555825ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T00:37:36.563259Z","caller":"traceutil/trace.go:171","msg":"trace[1935214493] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"301.555514ms","start":"2026-04-08T00:37:36.26168Z","end":"2026-04-08T00:37:36.563236Z","steps":["trace[1935214493] 'process raft request' (duration: 58.858817ms)","trace[1935214493] 'compare' (duration: 242.37548ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T00:37:36.5633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:37:36.26166Z","time spent":"301.621255ms","remote":"127.0.0.1:58724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T00:37:36.600411Z","caller":"traceutil/trace.go:171","msg":"trace[633295946] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"338.591269ms","start":"2026-04-08T00:37:36.261794Z","end":"2026-04-08T00:37:36.600385Z","steps":["trace[633295946] 'process raft request' (duration: 338.410916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:37:36.600548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:37:36.261775Z","time spent":"338.698902ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T00:37:36.600632Z","caller":"traceutil/trace.go:171","msg":"trace[1141837008] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"338.775833ms","start":"2026-04-08T00:37:36.261795Z","end":"2026-04-08T00:37:36.600571Z","steps":["trace[1141837008] 'process raft request' (duration: 338.529588ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:37:36.600783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:37:36.261771Z","time spent":"338.936477ms","remote":"127.0.0.1:58724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T00:37:36.600833Z","caller":"traceutil/trace.go:171","msg":"trace[794463854] linearizableReadLoop","detail":"{readStateIndex:1943; appliedIndex:1939; }","duration":"252.423599ms","start":"2026-04-08T00:37:36.3484Z","end":"2026-04-08T00:37:36.600824Z","steps":["trace[794463854] 'read index received' (duration: 251.728434ms)","trace[794463854] 'applied index is now lower than readState.Index' (duration: 694.715µs)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:37:36.600786Z","caller":"traceutil/trace.go:171","msg":"trace[1316022017] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"338.097571ms","start":"2026-04-08T00:37:36.262677Z","end":"2026-04-08T00:37:36.600774Z","steps":["trace[1316022017] 'process raft request' (duration: 337.819444ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:37:36.60096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.568422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T00:37:36.600986Z","caller":"traceutil/trace.go:171","msg":"trace[146533586] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1870; }","duration":"252.647284ms","start":"2026-04-08T00:37:36.348332Z","end":"2026-04-08T00:37:36.60098Z","steps":["trace[146533586] 'agreement among raft nodes before linearized reading' (duration: 252.549912ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:37:36.601061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:37:36.26266Z","time spent":"338.270425ms","remote":"127.0.0.1:58856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T00:37:36.601163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.771096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-08T00:37:36.600878Z","caller":"traceutil/trace.go:171","msg":"trace[689547641] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"335.116952ms","start":"2026-04-08T00:37:36.265752Z","end":"2026-04-08T00:37:36.600869Z","steps":["trace[689547641] 'process raft request' (duration: 334.895527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:37:36.601609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:37:36.265737Z","time spent":"335.828016ms","remote":"127.0.0.1:58736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-08T00:37:36.601762Z","caller":"traceutil/trace.go:171","msg":"trace[1108622928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1870; }","duration":"253.120612ms","start":"2026-04-08T00:37:36.348343Z","end":"2026-04-08T00:37:36.601463Z","steps":["trace[1108622928] 'agreement among raft nodes before linearized reading' (duration: 252.739645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:37:37.072942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.62079ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-08T00:37:37.073026Z","caller":"traceutil/trace.go:171","msg":"trace[973789650] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1873; }","duration":"201.798104ms","start":"2026-04-08T00:37:36.871209Z","end":"2026-04-08T00:37:37.073007Z","steps":["trace[973789650] 'range keys from in-memory index tree' (duration: 201.455908ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:38:15.401689Z","caller":"traceutil/trace.go:171","msg":"trace[1988363178] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"104.38381ms","start":"2026-04-08T00:38:15.297269Z","end":"2026-04-08T00:38:15.401652Z","steps":["trace[1988363178] 'process raft request' (duration: 104.191356ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:38:27.045785Z","caller":"traceutil/trace.go:171","msg":"trace[1846983626] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"130.121475ms","start":"2026-04-08T00:38:26.915631Z","end":"2026-04-08T00:38:27.045752Z","steps":["trace[1846983626] 'process raft request' (duration: 129.779198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:38:27.339983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.966296ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-08T00:38:27.340237Z","caller":"traceutil/trace.go:171","msg":"trace[236912037] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"290.183646ms","start":"2026-04-08T00:38:27.050009Z","end":"2026-04-08T00:38:27.340193Z","steps":["trace[236912037] 'process raft request' (duration: 126.885383ms)","trace[236912037] 'compare' (duration: 162.738482ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:38:27.340427Z","caller":"traceutil/trace.go:171","msg":"trace[106485341] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"290.025063ms","start":"2026-04-08T00:38:27.050378Z","end":"2026-04-08T00:38:27.340403Z","steps":["trace[106485341] 'process raft request' (duration: 289.729317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:39:53.716417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.183676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:39:53.716526Z","caller":"traceutil/trace.go:171","msg":"trace[225265318] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2851; }","duration":"160.36401ms","start":"2026-04-08T00:39:53.556142Z","end":"2026-04-08T00:39:53.716506Z","steps":["trace[225265318] 'count revisions from in-memory index tree' (duration: 160.098155ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:39:53.716831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.365362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:39:53.716943Z","caller":"traceutil/trace.go:171","msg":"trace[888796738] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2851; }","duration":"129.544777ms","start":"2026-04-08T00:39:53.587376Z","end":"2026-04-08T00:39:53.71692Z","steps":["trace[888796738] 'range keys from in-memory index tree' (duration: 129.23164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:43:43.762818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.6538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-08T00:43:43.762893Z","caller":"traceutil/trace.go:171","msg":"trace[869056269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4983; }","duration":"176.774963ms","start":"2026-04-08T00:43:43.586102Z","end":"2026-04-08T00:43:43.762877Z","steps":["trace[869056269] 'range keys from in-memory index tree' (duration: 176.559238ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:43:43.762904Z","caller":"traceutil/trace.go:171","msg":"trace[1900613103] transaction","detail":"{read_only:false; response_revision:4984; number_of_response:1; }","duration":"151.596757ms","start":"2026-04-08T00:43:43.611278Z","end":"2026-04-08T00:43:43.762875Z","steps":["trace[1900613103] 'process raft request' (duration: 97.113325ms)","trace[1900613103] 'compare' (duration: 54.175875ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:43:54.523584Z","caller":"traceutil/trace.go:171","msg":"trace[1396859972] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"112.55262ms","start":"2026-04-08T00:43:54.410989Z","end":"2026-04-08T00:43:54.523542Z","steps":["trace[1396859972] 'process raft request' (duration: 46.815775ms)","trace[1396859972] 'compare' (duration: 65.50803ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:44:06.854828Z","caller":"traceutil/trace.go:171","msg":"trace[704743877] transaction","detail":"{read_only:false; response_revision:5362; number_of_response:1; }","duration":"110.920906ms","start":"2026-04-08T00:44:06.743881Z","end":"2026-04-08T00:44:06.854802Z","steps":["trace[704743877] 'process raft request' (duration: 110.756942ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:44:37.304588Z","caller":"traceutil/trace.go:171","msg":"trace[565704682] linearizableReadLoop","detail":"{readStateIndex:5797; appliedIndex:5796; }","duration":"263.34109ms","start":"2026-04-08T00:44:37.041224Z","end":"2026-04-08T00:44:37.304565Z","steps":["trace[565704682] 'read index received' (duration: 217.669798ms)","trace[565704682] 'applied index is now lower than readState.Index' (duration: 45.670062ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T00:44:37.304822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.027154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-08T00:44:37.304861Z","caller":"traceutil/trace.go:171","msg":"trace[666107161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5587; }","duration":"329.105066ms","start":"2026-04-08T00:44:36.975746Z","end":"2026-04-08T00:44:37.304851Z","steps":["trace[666107161] 'agreement among raft nodes before linearized reading' (duration: 328.958693ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:44:37.304858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.451035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-08T00:44:37.304939Z","caller":"traceutil/trace.go:171","msg":"trace[1770666455] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5587; }","duration":"300.579687ms","start":"2026-04-08T00:44:37.004338Z","end":"2026-04-08T00:44:37.304918Z","steps":["trace[1770666455] 'agreement among raft nodes before linearized reading' (duration: 300.351532ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:44:37.304944Z","caller":"traceutil/trace.go:171","msg":"trace[214973148] transaction","detail":"{read_only:false; response_revision:5587; number_of_response:1; }","duration":"337.15811ms","start":"2026-04-08T00:44:36.96777Z","end":"2026-04-08T00:44:37.304928Z","steps":["trace[214973148] 'process raft request' (duration: 291.228814ms)","trace[214973148] 'compare' (duration: 45.468115ms)"],"step_count":2} {"level":"warn","ts":"2026-04-08T00:44:37.304981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:44:37.004326Z","time spent":"300.646879ms","remote":"127.0.0.1:58840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-08T00:44:37.305058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:44:36.967749Z","time spent":"337.236483ms","remote":"127.0.0.1:58840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-08T00:44:37.305044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.064009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-04-08T00:44:37.304893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:44:36.975736Z","time spent":"329.149066ms","remote":"127.0.0.1:58840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-08T00:44:37.305148Z","caller":"traceutil/trace.go:171","msg":"trace[1806171501] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:5587; }","duration":"260.227812ms","start":"2026-04-08T00:44:37.044894Z","end":"2026-04-08T00:44:37.305122Z","steps":["trace[1806171501] 'agreement among raft nodes before linearized reading' (duration: 260.005168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:44:37.305271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.986483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-08T00:44:37.305302Z","caller":"traceutil/trace.go:171","msg":"trace[803864892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5587; }","duration":"109.057555ms","start":"2026-04-08T00:44:37.196234Z","end":"2026-04-08T00:44:37.305291Z","steps":["trace[803864892] 'agreement among raft nodes before linearized reading' (duration: 108.972213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:44:37.305647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.15329ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-08T00:44:37.305699Z","caller":"traceutil/trace.go:171","msg":"trace[1528374267] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5587; }","duration":"260.251202ms","start":"2026-04-08T00:44:37.045434Z","end":"2026-04-08T00:44:37.305685Z","steps":["trace[1528374267] 'agreement among raft nodes before linearized reading' (duration: 259.995647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:44:37.30647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.744876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:87 size:64629"} {"level":"info","ts":"2026-04-08T00:44:37.306558Z","caller":"traceutil/trace.go:171","msg":"trace[1587161601] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:87; response_revision:5587; }","duration":"340.41019ms","start":"2026-04-08T00:44:36.966125Z","end":"2026-04-08T00:44:37.306536Z","steps":["trace[1587161601] 'agreement among raft nodes before linearized reading' (duration: 339.237275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:44:37.306776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-08T00:44:36.966069Z","time spent":"340.623015ms","remote":"127.0.0.1:58616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":87,"response size":64651,"request content":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 "} {"level":"info","ts":"2026-04-08T00:44:37.415396Z","caller":"traceutil/trace.go:171","msg":"trace[1884186244] linearizableReadLoop","detail":"{readStateIndex:5798; appliedIndex:5797; }","duration":"105.732382ms","start":"2026-04-08T00:44:37.309638Z","end":"2026-04-08T00:44:37.41537Z","steps":["trace[1884186244] 'read index received' (duration: 104.536617ms)","trace[1884186244] 'applied index is now lower than readState.Index' (duration: 1.194535ms)"],"step_count":2} {"level":"info","ts":"2026-04-08T00:44:37.415527Z","caller":"traceutil/trace.go:171","msg":"trace[1427162034] transaction","detail":"{read_only:false; response_revision:5588; number_of_response:1; }","duration":"106.980159ms","start":"2026-04-08T00:44:37.308513Z","end":"2026-04-08T00:44:37.415493Z","steps":["trace[1427162034] 'process raft request' (duration: 105.669471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-08T00:44:37.415678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.017698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" limit:500 ","response":"range_response_count:4 size:329952"} {"level":"info","ts":"2026-04-08T00:44:37.415753Z","caller":"traceutil/trace.go:171","msg":"trace[281395488] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:5588; }","duration":"106.147931ms","start":"2026-04-08T00:44:37.309589Z","end":"2026-04-08T00:44:37.415737Z","steps":["trace[281395488] 'agreement among raft nodes before linearized reading' (duration: 105.874565ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:44:37.454588Z","caller":"traceutil/trace.go:171","msg":"trace[1147078155] transaction","detail":"{read_only:false; response_revision:5589; number_of_response:1; }","duration":"144.855621ms","start":"2026-04-08T00:44:37.30969Z","end":"2026-04-08T00:44:37.454545Z","steps":["trace[1147078155] 'process raft request' (duration: 144.608666ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:44:37.454593Z","caller":"traceutil/trace.go:171","msg":"trace[1067756536] transaction","detail":"{read_only:false; response_revision:5591; number_of_response:1; }","duration":"144.624227ms","start":"2026-04-08T00:44:37.309949Z","end":"2026-04-08T00:44:37.454573Z","steps":["trace[1067756536] 'process raft request' (duration: 144.545595ms)"],"step_count":1} {"level":"info","ts":"2026-04-08T00:44:37.454657Z","caller":"traceutil/trace.go:171","msg":"trace[1810221301] transaction","detail":"{read_only:false; response_revision:5590; number_of_response:1; }","duration":"144.84637ms","start":"2026-04-08T00:44:37.309765Z","end":"2026-04-08T00:44:37.454612Z","steps":["trace[1810221301] 'process raft request' (duration: 144.679957ms)"],"step_count":1}