{"level":"warn","ts":"2026-06-23T18:42:15.097872Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T18:42:15.098029Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.227: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.227:2380","--initial-cluster=instance=https://199.204.45.227:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.227:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.227: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-06-23T18:42:15.098295Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-23T18:42:15.098324Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-23T18:42:15.098471Z","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-06-23T18:42:15.10019Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"]} {"level":"info","ts":"2026-06-23T18:42:15.100406Z","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.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.227: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-06-23T18:42:15.10454Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.440375ms"} {"level":"info","ts":"2026-06-23T18:42:15.111046Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"572db18442eba1c2","cluster-id":"fb1028a037bf3cd6"} {"level":"info","ts":"2026-06-23T18:42:15.11116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=()"} {"level":"info","ts":"2026-06-23T18:42:15.111197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 0"} {"level":"info","ts":"2026-06-23T18:42:15.111217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 572db18442eba1c2 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-23T18:42:15.111234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became follower at term 1"} {"level":"info","ts":"2026-06-23T18:42:15.111281Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"warn","ts":"2026-06-23T18:42:15.118124Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-23T18:42:15.119775Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-23T18:42:15.120958Z","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-06-23T18:42:15.123953Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"572db18442eba1c2","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-23T18:42:15.124204Z","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-06-23T18:42:15.124324Z","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-06-23T18:42:15.124339Z","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-06-23T18:42:15.124431Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"572db18442eba1c2","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-23T18:42:15.126246Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 switched to configuration voters=(6281872236868248002)"} {"level":"info","ts":"2026-06-23T18:42:15.126355Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","added-peer-id":"572db18442eba1c2","added-peer-peer-urls":["https://199.204.45.227:2380"]} {"level":"info","ts":"2026-06-23T18:42:15.128621Z","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-06-23T18:42:15.128723Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-23T18:42:15.128765Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.227:2380"} {"level":"info","ts":"2026-06-23T18:42:15.128954Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"572db18442eba1c2","initial-advertise-peer-urls":["https://199.204.45.227:2380"],"listen-peer-urls":["https://199.204.45.227:2380"],"advertise-client-urls":["https://199.204.45.227:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.227:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-23T18:42:15.129034Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-23T18:42:15.612226Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 is starting a new election at term 1"} {"level":"info","ts":"2026-06-23T18:42:15.612293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-23T18:42:15.612329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgPreVoteResp from 572db18442eba1c2 at term 1"} {"level":"info","ts":"2026-06-23T18:42:15.612353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became candidate at term 2"} {"level":"info","ts":"2026-06-23T18:42:15.61237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 received MsgVoteResp from 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-23T18:42:15.612392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"572db18442eba1c2 became leader at term 2"} {"level":"info","ts":"2026-06-23T18:42:15.61241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 572db18442eba1c2 elected leader 572db18442eba1c2 at term 2"} {"level":"info","ts":"2026-06-23T18:42:15.613379Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:42:15.614207Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"572db18442eba1c2","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.227:2379]}","request-path":"/0/members/572db18442eba1c2/attributes","cluster-id":"fb1028a037bf3cd6","publish-timeout":"7s"} {"level":"info","ts":"2026-06-23T18:42:15.614212Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T18:42:15.614344Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-23T18:42:15.614411Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"fb1028a037bf3cd6","local-member-id":"572db18442eba1c2","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:42:15.614531Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:42:15.614571Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-23T18:42:15.615657Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-23T18:42:15.615679Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-23T18:42:15.619128Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-23T18:42:15.627525Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.227:2379"} {"level":"info","ts":"2026-06-23T18:42:43.190233Z","caller":"traceutil/trace.go:171","msg":"trace[97152855] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"406.570245ms","start":"2026-06-23T18:42:42.783633Z","end":"2026-06-23T18:42:43.190204Z","steps":["trace[97152855] 'process raft request' (duration: 406.174995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:43.190864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:42.783594Z","time spent":"406.730521ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:42:51.882132Z","caller":"traceutil/trace.go:171","msg":"trace[1459594456] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:579; }","duration":"110.727991ms","start":"2026-06-23T18:42:51.771375Z","end":"2026-06-23T18:42:51.882103Z","steps":["trace[1459594456] 'read index received' (duration: 73.756705ms)","trace[1459594456] 'applied index is now lower than readState.Index' (duration: 36.970136ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:42:51.882323Z","caller":"traceutil/trace.go:171","msg":"trace[414695664] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"111.481191ms","start":"2026-06-23T18:42:51.770827Z","end":"2026-06-23T18:42:51.882308Z","steps":["trace[414695664] 'process raft request' (duration: 74.29201ms)","trace[414695664] 'compare' (duration: 36.864722ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:42:51.882518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.06528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:51.882612Z","caller":"traceutil/trace.go:171","msg":"trace[1048684774] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:560; }","duration":"111.265906ms","start":"2026-06-23T18:42:51.771327Z","end":"2026-06-23T18:42:51.882593Z","steps":["trace[1048684774] 'agreement among raft nodes before linearized reading' (duration: 111.07989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.435086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.488344ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:42:52.435297Z","caller":"traceutil/trace.go:171","msg":"trace[661817452] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"660.483355ms","start":"2026-06-23T18:42:51.774774Z","end":"2026-06-23T18:42:52.435258Z","steps":["trace[661817452] 'process raft request' (duration: 254.623551ms)","trace[661817452] 'compare' (duration: 405.35731ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:42:52.435426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.774743Z","time spent":"660.621807ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T18:42:52.435673Z","caller":"traceutil/trace.go:171","msg":"trace[1502001882] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:580; }","duration":"553.383104ms","start":"2026-06-23T18:42:51.882273Z","end":"2026-06-23T18:42:52.435656Z","steps":["trace[1502001882] 'read index received' (duration: 147.275583ms)","trace[1502001882] 'applied index is now lower than readState.Index' (duration: 406.106511ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:42:52.435721Z","caller":"traceutil/trace.go:171","msg":"trace[813883654] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"660.885316ms","start":"2026-06-23T18:42:51.774827Z","end":"2026-06-23T18:42:52.435713Z","steps":["trace[813883654] 'process raft request' (duration: 660.356821ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:42:52.435738Z","caller":"traceutil/trace.go:171","msg":"trace[1305621473] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"587.47339ms","start":"2026-06-23T18:42:51.848211Z","end":"2026-06-23T18:42:52.435684Z","steps":["trace[1305621473] 'process raft request' (duration: 587.056769ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:42:52.435756Z","caller":"traceutil/trace.go:171","msg":"trace[556463761] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"500.064966ms","start":"2026-06-23T18:42:51.935681Z","end":"2026-06-23T18:42:52.435746Z","steps":["trace[556463761] 'process raft request' (duration: 499.706796ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.435761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.774814Z","time spent":"660.928506ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-23T18:42:52.435761Z","caller":"traceutil/trace.go:171","msg":"trace[22994171] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"659.549479ms","start":"2026-06-23T18:42:51.776173Z","end":"2026-06-23T18:42:52.435722Z","steps":["trace[22994171] 'process raft request' (duration: 659.054165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.435825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.935653Z","time spent":"500.127928ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:42:52.435825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.848191Z","time spent":"587.589763ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T18:42:52.435944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.776166Z","time spent":"659.687883ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T18:42:52.436066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.023338ms","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-06-23T18:42:52.436125Z","caller":"traceutil/trace.go:171","msg":"trace[2099737899] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:565; }","duration":"662.105009ms","start":"2026-06-23T18:42:51.774004Z","end":"2026-06-23T18:42:52.436109Z","steps":["trace[2099737899] 'agreement among raft nodes before linearized reading' (duration: 661.975076ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.436056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.66504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:42:52.436144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"523.521178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-23T18:42:52.436161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.773995Z","time spent":"662.158311ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-06-23T18:42:52.436175Z","caller":"traceutil/trace.go:171","msg":"trace[1055913785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:565; }","duration":"523.593798ms","start":"2026-06-23T18:42:51.912573Z","end":"2026-06-23T18:42:52.436167Z","steps":["trace[1055913785] 'agreement among raft nodes before linearized reading' (duration: 523.425093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.436381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.912545Z","time spent":"523.831495ms","remote":"127.0.0.1:54928","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-06-23T18:42:52.436392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.313171ms","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-06-23T18:42:52.436419Z","caller":"traceutil/trace.go:171","msg":"trace[212099241] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:565; }","duration":"664.362162ms","start":"2026-06-23T18:42:51.772048Z","end":"2026-06-23T18:42:52.43641Z","steps":["trace[212099241] 'agreement among raft nodes before linearized reading' (duration: 664.318251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.436113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.594902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:42:52.436465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.772037Z","time spent":"664.418794ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"info","ts":"2026-06-23T18:42:52.436486Z","caller":"traceutil/trace.go:171","msg":"trace[1092142606] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:565; }","duration":"267.017544ms","start":"2026-06-23T18:42:52.16946Z","end":"2026-06-23T18:42:52.436477Z","steps":["trace[1092142606] 'agreement among raft nodes before linearized reading' (duration: 266.50208ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:42:52.436174Z","caller":"traceutil/trace.go:171","msg":"trace[2044987003] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:565; }","duration":"664.801694ms","start":"2026-06-23T18:42:51.771356Z","end":"2026-06-23T18:42:52.436158Z","steps":["trace[2044987003] 'agreement among raft nodes before linearized reading' (duration: 664.66707ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.436518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.747304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:42:52.436532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.771341Z","time spent":"665.182844ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"info","ts":"2026-06-23T18:42:52.436571Z","caller":"traceutil/trace.go:171","msg":"trace[795316819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:565; }","duration":"153.830565ms","start":"2026-06-23T18:42:52.282721Z","end":"2026-06-23T18:42:52.436552Z","steps":["trace[795316819] 'agreement among raft nodes before linearized reading' (duration: 153.772524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.436566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.916966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:52.436958Z","caller":"traceutil/trace.go:171","msg":"trace[667052407] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:565; }","duration":"467.35045ms","start":"2026-06-23T18:42:51.96959Z","end":"2026-06-23T18:42:52.436941Z","steps":["trace[667052407] 'agreement among raft nodes before linearized reading' (duration: 466.862096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:52.437001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:51.969578Z","time spent":"467.413201ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-06-23T18:42:52.436638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"293.342274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-ztr8t\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-06-23T18:42:52.437114Z","caller":"traceutil/trace.go:171","msg":"trace[1185420071] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-ztr8t; range_end:; response_count:1; response_revision:565; }","duration":"293.867619ms","start":"2026-06-23T18:42:52.143238Z","end":"2026-06-23T18:42:52.437106Z","steps":["trace[1185420071] 'agreement among raft nodes before linearized reading' (duration: 293.336134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.55627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.65334ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:42:54.556395Z","caller":"traceutil/trace.go:171","msg":"trace[1124564314] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"539.504211ms","start":"2026-06-23T18:42:54.016872Z","end":"2026-06-23T18:42:54.556376Z","steps":["trace[1124564314] 'process raft request' (duration: 200.657695ms)","trace[1124564314] 'compare' (duration: 338.487626ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:42:54.556463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.016817Z","time spent":"539.612284ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:42:54.559908Z","caller":"traceutil/trace.go:171","msg":"trace[1727593770] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:628; }","duration":"425.242912ms","start":"2026-06-23T18:42:54.134634Z","end":"2026-06-23T18:42:54.559876Z","steps":["trace[1727593770] 'read index received' (duration: 82.786646ms)","trace[1727593770] 'applied index is now lower than readState.Index' (duration: 342.455006ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:42:54.560123Z","caller":"traceutil/trace.go:171","msg":"trace[1634540376] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"526.561472ms","start":"2026-06-23T18:42:54.033549Z","end":"2026-06-23T18:42:54.56011Z","steps":["trace[1634540376] 'process raft request' (duration: 526.053177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.560231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.03353Z","time spent":"526.629893ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13205,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:42:54.560433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.634172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.560621Z","caller":"traceutil/trace.go:171","msg":"trace[27191786] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:609; }","duration":"426.009183ms","start":"2026-06-23T18:42:54.134593Z","end":"2026-06-23T18:42:54.560602Z","steps":["trace[27191786] 'agreement among raft nodes before linearized reading' (duration: 425.627863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.560858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.229645ms","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-06-23T18:42:54.560899Z","caller":"traceutil/trace.go:171","msg":"trace[1708741385] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:609; }","duration":"102.300477ms","start":"2026-06-23T18:42:54.458589Z","end":"2026-06-23T18:42:54.560889Z","steps":["trace[1708741385] 'agreement among raft nodes before linearized reading' (duration: 102.175874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.56082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.134577Z","time spent":"426.224689ms","remote":"127.0.0.1:54864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"warn","ts":"2026-06-23T18:42:54.561685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.186908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-06-23T18:42:54.561737Z","caller":"traceutil/trace.go:171","msg":"trace[1341956193] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:609; }","duration":"192.254422ms","start":"2026-06-23T18:42:54.369468Z","end":"2026-06-23T18:42:54.561723Z","steps":["trace[1341956193] 'agreement among raft nodes before linearized reading' (duration: 191.540252ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:42:54.561661Z","caller":"traceutil/trace.go:171","msg":"trace[1916580181] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"363.355156ms","start":"2026-06-23T18:42:54.19829Z","end":"2026-06-23T18:42:54.561645Z","steps":["trace[1916580181] 'process raft request' (duration: 361.519075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.561976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.155345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.562028Z","caller":"traceutil/trace.go:171","msg":"trace[124387339] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:609; }","duration":"207.215396ms","start":"2026-06-23T18:42:54.354789Z","end":"2026-06-23T18:42:54.562005Z","steps":["trace[124387339] 'agreement among raft nodes before linearized reading' (duration: 207.079952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.562213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.800202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.562252Z","caller":"traceutil/trace.go:171","msg":"trace[1144693993] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:609; }","duration":"207.843164ms","start":"2026-06-23T18:42:54.3544Z","end":"2026-06-23T18:42:54.562244Z","steps":["trace[1144693993] 'agreement among raft nodes before linearized reading' (duration: 207.786682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.562113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.198266Z","time spent":"363.681875ms","remote":"127.0.0.1:54708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T18:42:54.562366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.216374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.562399Z","caller":"traceutil/trace.go:171","msg":"trace[1411546831] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:609; }","duration":"208.285596ms","start":"2026-06-23T18:42:54.354105Z","end":"2026-06-23T18:42:54.562391Z","steps":["trace[1411546831] 'agreement among raft nodes before linearized reading' (duration: 208.240914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.562506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.822433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.562538Z","caller":"traceutil/trace.go:171","msg":"trace[992009458] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:609; }","duration":"251.890085ms","start":"2026-06-23T18:42:54.310641Z","end":"2026-06-23T18:42:54.562531Z","steps":["trace[992009458] 'agreement among raft nodes before linearized reading' (duration: 251.843484ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.56267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.370678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.562702Z","caller":"traceutil/trace.go:171","msg":"trace[1803740816] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:609; }","duration":"252.405139ms","start":"2026-06-23T18:42:54.310289Z","end":"2026-06-23T18:42:54.562695Z","steps":["trace[1803740816] 'agreement among raft nodes before linearized reading' (duration: 252.358307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.560506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.535344ms","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":"warn","ts":"2026-06-23T18:42:54.56298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.906169ms","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-06-23T18:42:54.563014Z","caller":"traceutil/trace.go:171","msg":"trace[1214222919] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:609; }","duration":"346.960041ms","start":"2026-06-23T18:42:54.216045Z","end":"2026-06-23T18:42:54.563005Z","steps":["trace[1214222919] 'agreement among raft nodes before linearized reading' (duration: 346.918419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.563045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.216036Z","time spent":"346.998801ms","remote":"127.0.0.1:35940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-23T18:42:54.563097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.062413ms","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-06-23T18:42:54.563181Z","caller":"traceutil/trace.go:171","msg":"trace[1638810508] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:609; }","duration":"347.211978ms","start":"2026-06-23T18:42:54.215955Z","end":"2026-06-23T18:42:54.563167Z","steps":["trace[1638810508] 'agreement among raft nodes before linearized reading' (duration: 347.056594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.563292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.215931Z","time spent":"347.348781ms","remote":"127.0.0.1:35940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-23T18:42:54.563109Z","caller":"traceutil/trace.go:171","msg":"trace[615181636] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:609; }","duration":"426.043334ms","start":"2026-06-23T18:42:54.136945Z","end":"2026-06-23T18:42:54.562988Z","steps":["trace[615181636] 'agreement among raft nodes before linearized reading' (duration: 423.526404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.563514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.136939Z","time spent":"426.526417ms","remote":"127.0.0.1:35920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-23T18:42:54.563691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.963671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.563731Z","caller":"traceutil/trace.go:171","msg":"trace[374394905] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:609; }","duration":"404.014672ms","start":"2026-06-23T18:42:54.159707Z","end":"2026-06-23T18:42:54.563722Z","steps":["trace[374394905] 'agreement among raft nodes before linearized reading' (duration: 403.970851ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.563754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.1597Z","time spent":"404.047823ms","remote":"127.0.0.1:35922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-06-23T18:42:54.56387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.25198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.563894Z","caller":"traceutil/trace.go:171","msg":"trace[655500448] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:609; }","duration":"426.27764ms","start":"2026-06-23T18:42:54.137611Z","end":"2026-06-23T18:42:54.563889Z","steps":["trace[655500448] 'agreement among raft nodes before linearized reading' (duration: 426.242978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.563914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.137595Z","time spent":"426.314482ms","remote":"127.0.0.1:35920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-23T18:42:54.56402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.032561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.564047Z","caller":"traceutil/trace.go:171","msg":"trace[1530988890] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:609; }","duration":"427.069772ms","start":"2026-06-23T18:42:54.136972Z","end":"2026-06-23T18:42:54.564042Z","steps":["trace[1530988890] 'agreement among raft nodes before linearized reading' (duration: 427.026481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.564068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.136967Z","time spent":"427.094402ms","remote":"127.0.0.1:35920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-23T18:42:54.562822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.663796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.564213Z","caller":"traceutil/trace.go:171","msg":"trace[2008095840] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:609; }","duration":"254.065505ms","start":"2026-06-23T18:42:54.31014Z","end":"2026-06-23T18:42:54.564205Z","steps":["trace[2008095840] 'agreement among raft nodes before linearized reading' (duration: 252.661116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.562857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.600503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.564301Z","caller":"traceutil/trace.go:171","msg":"trace[825229013] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:609; }","duration":"281.094416ms","start":"2026-06-23T18:42:54.283201Z","end":"2026-06-23T18:42:54.564296Z","steps":["trace[825229013] 'agreement among raft nodes before linearized reading' (duration: 279.636655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.563581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.582212ms","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":"warn","ts":"2026-06-23T18:42:54.562885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.22983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:42:54.564406Z","caller":"traceutil/trace.go:171","msg":"trace[1264032420] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:609; }","duration":"299.780244ms","start":"2026-06-23T18:42:54.26462Z","end":"2026-06-23T18:42:54.5644Z","steps":["trace[1264032420] 'agreement among raft nodes before linearized reading' (duration: 298.25059ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:42:54.564393Z","caller":"traceutil/trace.go:171","msg":"trace[731111835] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:609; }","duration":"377.395504ms","start":"2026-06-23T18:42:54.186989Z","end":"2026-06-23T18:42:54.564384Z","steps":["trace[731111835] 'agreement among raft nodes before linearized reading' (duration: 376.568002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.562949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.702924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:42:54.563611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.656264ms","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-06-23T18:42:54.563641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.254252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:42:54.563667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.678914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:42:54.562916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.403765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:42:54.564721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.186958Z","time spent":"377.752204ms","remote":"127.0.0.1:35934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-06-23T18:42:54.564731Z","caller":"traceutil/trace.go:171","msg":"trace[358273871] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:609; }","duration":"300.438471ms","start":"2026-06-23T18:42:54.264284Z","end":"2026-06-23T18:42:54.564722Z","steps":["trace[358273871] 'agreement among raft nodes before linearized reading' (duration: 298.616571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.564798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.264264Z","time spent":"300.522693ms","remote":"127.0.0.1:35942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-06-23T18:42:54.564835Z","caller":"traceutil/trace.go:171","msg":"trace[1520009448] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:609; }","duration":"404.490215ms","start":"2026-06-23T18:42:54.160337Z","end":"2026-06-23T18:42:54.564827Z","steps":["trace[1520009448] 'agreement among raft nodes before linearized reading' (duration: 403.291152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.564872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.160318Z","time spent":"404.544408ms","remote":"127.0.0.1:35922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"info","ts":"2026-06-23T18:42:54.564936Z","caller":"traceutil/trace.go:171","msg":"trace[1003550406] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:609; }","duration":"404.984679ms","start":"2026-06-23T18:42:54.159944Z","end":"2026-06-23T18:42:54.564929Z","steps":["trace[1003550406] 'agreement among raft nodes before linearized reading' (duration: 403.708275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.565363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.159926Z","time spent":"405.426791ms","remote":"127.0.0.1:35922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"info","ts":"2026-06-23T18:42:54.564986Z","caller":"traceutil/trace.go:171","msg":"trace[1579392557] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:609; }","duration":"378.072824ms","start":"2026-06-23T18:42:54.186904Z","end":"2026-06-23T18:42:54.564977Z","steps":["trace[1579392557] 'agreement among raft nodes before linearized reading' (duration: 376.693046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.565473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.186876Z","time spent":"378.583737ms","remote":"127.0.0.1:35934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-23T18:42:54.564692Z","caller":"traceutil/trace.go:171","msg":"trace[1676672581] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:609; }","duration":"348.463512ms","start":"2026-06-23T18:42:54.216222Z","end":"2026-06-23T18:42:54.564686Z","steps":["trace[1676672581] 'agreement among raft nodes before linearized reading' (duration: 346.710004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:42:54.565597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:42:54.216215Z","time spent":"349.373198ms","remote":"127.0.0.1:35934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-06-23T18:43:01.30001Z","caller":"traceutil/trace.go:171","msg":"trace[1635946277] transaction","detail":"{read_only:false; response_revision:659; number_of_response:1; }","duration":"120.019368ms","start":"2026-06-23T18:43:01.179964Z","end":"2026-06-23T18:43:01.299983Z","steps":["trace[1635946277] 'process raft request' (duration: 119.825212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:43:02.689906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.195795499s","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-06-23T18:43:02.689994Z","caller":"traceutil/trace.go:171","msg":"trace[401497265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:661; }","duration":"1.195932801s","start":"2026-06-23T18:43:01.494037Z","end":"2026-06-23T18:43:02.68997Z","steps":["trace[401497265] 'range keys from in-memory index tree' (duration: 1.195633124s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:43:02.690051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:43:01.49401Z","time spent":"1.196030495s","remote":"127.0.0.1:54928","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-06-23T18:43:02.689912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.236947ms","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-06-23T18:43:02.690118Z","caller":"traceutil/trace.go:171","msg":"trace[494244111] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:661; }","duration":"669.484275ms","start":"2026-06-23T18:43:02.020613Z","end":"2026-06-23T18:43:02.690097Z","steps":["trace[494244111] 'range keys from in-memory index tree' (duration: 669.031872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:43:02.690197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:43:02.020592Z","time spent":"669.577356ms","remote":"127.0.0.1:54928","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-06-23T18:43:22.784723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.228135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-23T18:43:22.784753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.490712ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2qqpt\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-23T18:43:22.784814Z","caller":"traceutil/trace.go:171","msg":"trace[748118627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"503.339218ms","start":"2026-06-23T18:43:22.281452Z","end":"2026-06-23T18:43:22.784791Z","steps":["trace[748118627] 'range keys from in-memory index tree' (duration: 503.190304ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:43:22.784856Z","caller":"traceutil/trace.go:171","msg":"trace[1029038413] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2qqpt; range_end:; response_count:1; response_revision:786; }","duration":"503.642386ms","start":"2026-06-23T18:43:22.281186Z","end":"2026-06-23T18:43:22.784829Z","steps":["trace[1029038413] 'range keys from in-memory index tree' (duration: 503.269415ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:43:22.784876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:43:22.281447Z","time spent":"503.41971ms","remote":"127.0.0.1:54668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T18:43:22.78491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:43:22.281167Z","time spent":"503.725979ms","remote":"127.0.0.1:54840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2qqpt\" "} {"level":"info","ts":"2026-06-23T18:43:22.923323Z","caller":"traceutil/trace.go:171","msg":"trace[1410546681] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"131.523947ms","start":"2026-06-23T18:43:22.791779Z","end":"2026-06-23T18:43:22.923303Z","steps":["trace[1410546681] 'process raft request' (duration: 131.368643ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:43:57.366317Z","caller":"traceutil/trace.go:171","msg":"trace[1341355447] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"271.483922ms","start":"2026-06-23T18:43:57.094813Z","end":"2026-06-23T18:43:57.366297Z","steps":["trace[1341355447] 'read index received' (duration: 271.341099ms)","trace[1341355447] 'applied index is now lower than readState.Index' (duration: 141.823µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:43:57.366409Z","caller":"traceutil/trace.go:171","msg":"trace[866454629] transaction","detail":"{read_only:false; response_revision:996; number_of_response:1; }","duration":"272.001737ms","start":"2026-06-23T18:43:57.0944Z","end":"2026-06-23T18:43:57.366402Z","steps":["trace[866454629] 'process raft request' (duration: 271.768651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:43:57.366729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.889544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-23T18:43:57.366835Z","caller":"traceutil/trace.go:171","msg":"trace[1711283084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:996; }","duration":"272.022588ms","start":"2026-06-23T18:43:57.094788Z","end":"2026-06-23T18:43:57.36681Z","steps":["trace[1711283084] 'agreement among raft nodes before linearized reading' (duration: 271.776791ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:43:57.540379Z","caller":"traceutil/trace.go:171","msg":"trace[1864535795] linearizableReadLoop","detail":"{readStateIndex:1035; appliedIndex:1034; }","duration":"173.983203ms","start":"2026-06-23T18:43:57.366375Z","end":"2026-06-23T18:43:57.540349Z","steps":["trace[1864535795] 'read index received' (duration: 173.927922ms)","trace[1864535795] 'applied index is now lower than readState.Index' (duration: 45.1µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:43:57.540477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.501722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:43:57.5405Z","caller":"traceutil/trace.go:171","msg":"trace[1659560157] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:997; }","duration":"235.569855ms","start":"2026-06-23T18:43:57.304924Z","end":"2026-06-23T18:43:57.540494Z","steps":["trace[1659560157] 'agreement among raft nodes before linearized reading' (duration: 235.510543ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:43:57.541051Z","caller":"traceutil/trace.go:171","msg":"trace[1458937082] transaction","detail":"{read_only:false; response_revision:998; number_of_response:1; }","duration":"170.292642ms","start":"2026-06-23T18:43:57.370745Z","end":"2026-06-23T18:43:57.541038Z","steps":["trace[1458937082] 'process raft request' (duration: 170.19967ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:43:57.540612Z","caller":"traceutil/trace.go:171","msg":"trace[1222718860] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"444.530869ms","start":"2026-06-23T18:43:57.096027Z","end":"2026-06-23T18:43:57.540558Z","steps":["trace[1222718860] 'process raft request' (duration: 444.21333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:43:57.541505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:43:57.096015Z","time spent":"445.386474ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:44:28.882948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:28.494543Z","time spent":"388.400871ms","remote":"127.0.0.1:54686","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-23T18:44:29.311991Z","caller":"traceutil/trace.go:171","msg":"trace[2145929761] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"427.932098ms","start":"2026-06-23T18:44:28.884034Z","end":"2026-06-23T18:44:29.311966Z","steps":["trace[2145929761] 'process raft request' (duration: 427.751083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:29.31212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:28.884014Z","time spent":"428.03232ms","remote":"127.0.0.1:54686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:44:30.128235Z","caller":"traceutil/trace.go:171","msg":"trace[926768378] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"152.078955ms","start":"2026-06-23T18:44:29.976131Z","end":"2026-06-23T18:44:30.12821Z","steps":["trace[926768378] 'process raft request' (duration: 133.011765ms)","trace[926768378] 'compare' (duration: 18.974597ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:44:34.104639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.668255ms","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-06-23T18:44:34.104695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.053552ms","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-06-23T18:44:34.104731Z","caller":"traceutil/trace.go:171","msg":"trace[154041476] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1116; }","duration":"385.801578ms","start":"2026-06-23T18:44:33.718909Z","end":"2026-06-23T18:44:34.10471Z","steps":["trace[154041476] 'range keys from in-memory index tree' (duration: 385.49387ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:44:34.10478Z","caller":"traceutil/trace.go:171","msg":"trace[1182927752] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1116; }","duration":"387.196197ms","start":"2026-06-23T18:44:33.717561Z","end":"2026-06-23T18:44:34.104757Z","steps":["trace[1182927752] 'range keys from in-memory index tree' (duration: 386.884118ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:34.104798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:33.718893Z","time spent":"385.89265ms","remote":"127.0.0.1:54928","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-06-23T18:44:34.104829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:33.717544Z","time spent":"387.275159ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-23T18:44:34.138526Z","caller":"traceutil/trace.go:171","msg":"trace[2123908160] linearizableReadLoop","detail":"{readStateIndex:1163; appliedIndex:1161; }","duration":"153.943447ms","start":"2026-06-23T18:44:33.984569Z","end":"2026-06-23T18:44:34.138513Z","steps":["trace[2123908160] 'read index received' (duration: 86.39693ms)","trace[2123908160] 'applied index is now lower than readState.Index' (duration: 67.545747ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:44:34.138596Z","caller":"traceutil/trace.go:171","msg":"trace[1899813556] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"202.681511ms","start":"2026-06-23T18:44:33.935889Z","end":"2026-06-23T18:44:34.13857Z","steps":["trace[1899813556] 'process raft request' (duration: 202.542867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:34.138672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.098421ms","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-06-23T18:44:34.13871Z","caller":"traceutil/trace.go:171","msg":"trace[2084046214] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1117; }","duration":"154.180514ms","start":"2026-06-23T18:44:33.984518Z","end":"2026-06-23T18:44:34.138699Z","steps":["trace[2084046214] 'agreement among raft nodes before linearized reading' (duration: 154.054001ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:44:44.64065Z","caller":"traceutil/trace.go:171","msg":"trace[512607796] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"422.351404ms","start":"2026-06-23T18:44:44.218275Z","end":"2026-06-23T18:44:44.640627Z","steps":["trace[512607796] 'process raft request' (duration: 422.067376ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:44:44.64065Z","caller":"traceutil/trace.go:171","msg":"trace[680962632] transaction","detail":"{read_only:false; response_revision:1154; number_of_response:1; }","duration":"421.973264ms","start":"2026-06-23T18:44:44.218648Z","end":"2026-06-23T18:44:44.640621Z","steps":["trace[680962632] 'process raft request' (duration: 421.826369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:44.640836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:44.218263Z","time spent":"422.476107ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:44:44.640934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:44.21864Z","time spent":"422.242781ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:44:45.973109Z","caller":"traceutil/trace.go:171","msg":"trace[1011584637] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"198.296429ms","start":"2026-06-23T18:44:45.774792Z","end":"2026-06-23T18:44:45.973089Z","steps":["trace[1011584637] 'process raft request' (duration: 198.103903ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:44:46.711161Z","caller":"traceutil/trace.go:171","msg":"trace[2004486816] transaction","detail":"{read_only:false; response_revision:1158; number_of_response:1; }","duration":"409.092694ms","start":"2026-06-23T18:44:46.302049Z","end":"2026-06-23T18:44:46.711141Z","steps":["trace[2004486816] 'process raft request' (duration: 408.755755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:46.711411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:46.302032Z","time spent":"409.308301ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:44:47.592554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.587326ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:44:47.592734Z","caller":"traceutil/trace.go:171","msg":"trace[1500123881] linearizableReadLoop","detail":"{readStateIndex:1208; appliedIndex:1206; }","duration":"306.735591ms","start":"2026-06-23T18:44:47.285962Z","end":"2026-06-23T18:44:47.592697Z","steps":["trace[1500123881] 'read index received' (duration: 247.631459ms)","trace[1500123881] 'applied index is now lower than readState.Index' (duration: 59.099072ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:44:47.592774Z","caller":"traceutil/trace.go:171","msg":"trace[267330704] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"876.84813ms","start":"2026-06-23T18:44:46.715903Z","end":"2026-06-23T18:44:47.592751Z","steps":["trace[267330704] 'process raft request' (duration: 361.987346ms)","trace[267330704] 'compare' (duration: 514.507604ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:44:47.592831Z","caller":"traceutil/trace.go:171","msg":"trace[213170365] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"876.436339ms","start":"2026-06-23T18:44:46.716385Z","end":"2026-06-23T18:44:47.592821Z","steps":["trace[213170365] 'process raft request' (duration: 876.259184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:47.592877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:46.71588Z","time spent":"876.938293ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:44:47.592887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:46.716361Z","time spent":"876.49598ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:44:47.592793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.832004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:44:47.593035Z","caller":"traceutil/trace.go:171","msg":"trace[815326664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1160; }","duration":"307.110112ms","start":"2026-06-23T18:44:47.285915Z","end":"2026-06-23T18:44:47.593025Z","steps":["trace[815326664] 'agreement among raft nodes before linearized reading' (duration: 306.847586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:47.593067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:47.285895Z","time spent":"307.156243ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-23T18:44:48.84624Z","caller":"traceutil/trace.go:171","msg":"trace[945141951] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"126.399521ms","start":"2026-06-23T18:44:48.719817Z","end":"2026-06-23T18:44:48.846216Z","steps":["trace[945141951] 'process raft request' (duration: 126.273487ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:44:50.449213Z","caller":"traceutil/trace.go:171","msg":"trace[156751479] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"406.904905ms","start":"2026-06-23T18:44:50.042283Z","end":"2026-06-23T18:44:50.449188Z","steps":["trace[156751479] 'process raft request' (duration: 406.754061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:50.449409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:44:50.042272Z","time spent":"407.044788ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:44:50.467833Z","caller":"traceutil/trace.go:171","msg":"trace[1964891657] linearizableReadLoop","detail":"{readStateIndex:1218; appliedIndex:1216; }","duration":"184.391994ms","start":"2026-06-23T18:44:50.283397Z","end":"2026-06-23T18:44:50.467789Z","steps":["trace[1964891657] 'read index received' (duration: 165.625723ms)","trace[1964891657] 'applied index is now lower than readState.Index' (duration: 18.764931ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:44:50.467899Z","caller":"traceutil/trace.go:171","msg":"trace[1581476932] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"204.05838ms","start":"2026-06-23T18:44:50.263818Z","end":"2026-06-23T18:44:50.467876Z","steps":["trace[1581476932] 'process raft request' (duration: 203.817723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:50.468031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.624541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:44:50.46808Z","caller":"traceutil/trace.go:171","msg":"trace[60337041] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1169; }","duration":"184.726553ms","start":"2026-06-23T18:44:50.28334Z","end":"2026-06-23T18:44:50.468066Z","steps":["trace[60337041] 'agreement among raft nodes before linearized reading' (duration: 184.62002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:44:50.468183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.488354ms","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-06-23T18:44:50.468308Z","caller":"traceutil/trace.go:171","msg":"trace[165692734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1169; }","duration":"144.644778ms","start":"2026-06-23T18:44:50.323621Z","end":"2026-06-23T18:44:50.468266Z","steps":["trace[165692734] 'agreement among raft nodes before linearized reading' (duration: 144.385712ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:03.617939Z","caller":"traceutil/trace.go:171","msg":"trace[513755693] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"138.926317ms","start":"2026-06-23T18:45:03.478969Z","end":"2026-06-23T18:45:03.617895Z","steps":["trace[513755693] 'process raft request' (duration: 71.051193ms)","trace[513755693] 'compare' (duration: 67.72025ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:03.617968Z","caller":"traceutil/trace.go:171","msg":"trace[1669600996] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"136.994823ms","start":"2026-06-23T18:45:03.480949Z","end":"2026-06-23T18:45:03.617944Z","steps":["trace[1669600996] 'process raft request' (duration: 136.89099ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:03.618032Z","caller":"traceutil/trace.go:171","msg":"trace[1562801960] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"109.389272ms","start":"2026-06-23T18:45:03.508631Z","end":"2026-06-23T18:45:03.61802Z","steps":["trace[1562801960] 'process raft request' (duration: 109.356161ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:03.618161Z","caller":"traceutil/trace.go:171","msg":"trace[511920612] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"113.939917ms","start":"2026-06-23T18:45:03.504213Z","end":"2026-06-23T18:45:03.618153Z","steps":["trace[511920612] 'process raft request' (duration: 113.706861ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:03.767233Z","caller":"traceutil/trace.go:171","msg":"trace[1594613749] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"111.314523ms","start":"2026-06-23T18:45:03.655885Z","end":"2026-06-23T18:45:03.767199Z","steps":["trace[1594613749] 'process raft request' (duration: 110.789109ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:03.828863Z","caller":"traceutil/trace.go:171","msg":"trace[916822969] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"108.874487ms","start":"2026-06-23T18:45:03.719958Z","end":"2026-06-23T18:45:03.828833Z","steps":["trace[916822969] 'process raft request' (duration: 108.592679ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:03.828914Z","caller":"traceutil/trace.go:171","msg":"trace[645340403] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"108.200798ms","start":"2026-06-23T18:45:03.720693Z","end":"2026-06-23T18:45:03.828893Z","steps":["trace[645340403] 'process raft request' (duration: 107.992642ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:03.829365Z","caller":"traceutil/trace.go:171","msg":"trace[289038412] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"104.466486ms","start":"2026-06-23T18:45:03.724879Z","end":"2026-06-23T18:45:03.829345Z","steps":["trace[289038412] 'process raft request' (duration: 103.965853ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:03.829519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.383633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/ceph-csi-rbd-provisioner\" ","response":"range_response_count:1 size:10872"} {"level":"info","ts":"2026-06-23T18:45:03.829632Z","caller":"traceutil/trace.go:171","msg":"trace[1818243380] range","detail":"{range_begin:/registry/deployments/kube-system/ceph-csi-rbd-provisioner; range_end:; response_count:1; response_revision:1252; }","duration":"104.555678ms","start":"2026-06-23T18:45:03.725059Z","end":"2026-06-23T18:45:03.829615Z","steps":["trace[1818243380] 'agreement among raft nodes before linearized reading' (duration: 104.305621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:07.782536Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053564086145571,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T18:45:08.03202Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.009611474s","expected-duration":"1s"} {"level":"info","ts":"2026-06-23T18:45:08.032388Z","caller":"traceutil/trace.go:171","msg":"trace[1565855897] linearizableReadLoop","detail":"{readStateIndex:1329; appliedIndex:1328; }","duration":"750.105258ms","start":"2026-06-23T18:45:07.28226Z","end":"2026-06-23T18:45:08.032366Z","steps":["trace[1565855897] 'read index received' (duration: 749.902613ms)","trace[1565855897] 'applied index is now lower than readState.Index' (duration: 201.795µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:08.03247Z","caller":"traceutil/trace.go:171","msg":"trace[1667101571] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"1.010119548s","start":"2026-06-23T18:45:07.02234Z","end":"2026-06-23T18:45:08.032459Z","steps":["trace[1667101571] 'process raft request' (duration: 1.009876602s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:08.032568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:07.02233Z","time spent":"1.01016636s","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:45:08.032581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.365015ms","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-06-23T18:45:08.032617Z","caller":"traceutil/trace.go:171","msg":"trace[618853873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1275; }","duration":"153.435558ms","start":"2026-06-23T18:45:07.879172Z","end":"2026-06-23T18:45:08.032607Z","steps":["trace[618853873] 'agreement among raft nodes before linearized reading' (duration: 153.309445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:08.032785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.51051ms","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-06-23T18:45:08.03288Z","caller":"traceutil/trace.go:171","msg":"trace[73050400] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1275; }","duration":"153.646933ms","start":"2026-06-23T18:45:07.879212Z","end":"2026-06-23T18:45:08.032859Z","steps":["trace[73050400] 'agreement among raft nodes before linearized reading' (duration: 153.442008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:08.032856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.566111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:45:08.033064Z","caller":"traceutil/trace.go:171","msg":"trace[698335187] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1275; }","duration":"750.822228ms","start":"2026-06-23T18:45:07.282216Z","end":"2026-06-23T18:45:08.033038Z","steps":["trace[698335187] 'agreement among raft nodes before linearized reading' (duration: 750.424696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:08.033129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:07.282195Z","time spent":"750.92186ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T18:45:08.458892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.93874ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:08.458999Z","caller":"traceutil/trace.go:171","msg":"trace[1743617740] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1329; }","duration":"175.820476ms","start":"2026-06-23T18:45:08.283169Z","end":"2026-06-23T18:45:08.45899Z","steps":["trace[1743617740] 'read index received' (duration: 173.639876ms)","trace[1743617740] 'applied index is now lower than readState.Index' (duration: 2.1802ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:08.459053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.893877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:45:08.459072Z","caller":"traceutil/trace.go:171","msg":"trace[237086884] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1277; }","duration":"175.94991ms","start":"2026-06-23T18:45:08.283117Z","end":"2026-06-23T18:45:08.459067Z","steps":["trace[237086884] 'agreement among raft nodes before linearized reading' (duration: 175.898088ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:08.459269Z","caller":"traceutil/trace.go:171","msg":"trace[1220996982] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"422.293773ms","start":"2026-06-23T18:45:08.036966Z","end":"2026-06-23T18:45:08.45926Z","steps":["trace[1220996982] 'process raft request' (duration: 182.937553ms)","trace[1220996982] 'compare' (duration: 238.633181ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:08.459315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:08.036948Z","time spent":"422.345475ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:45:08.459317Z","caller":"traceutil/trace.go:171","msg":"trace[2087677366] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"421.399539ms","start":"2026-06-23T18:45:08.03787Z","end":"2026-06-23T18:45:08.45927Z","steps":["trace[2087677366] 'process raft request' (duration: 421.087811ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:08.459481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:08.037857Z","time spent":"421.534083ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:45:20.257502Z","caller":"traceutil/trace.go:171","msg":"trace[192739318] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"174.926961ms","start":"2026-06-23T18:45:20.082555Z","end":"2026-06-23T18:45:20.257481Z","steps":["trace[192739318] 'process raft request' (duration: 174.810598ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:22.47013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.700853ms","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-06-23T18:45:22.470247Z","caller":"traceutil/trace.go:171","msg":"trace[672069395] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1321; }","duration":"532.886428ms","start":"2026-06-23T18:45:21.937336Z","end":"2026-06-23T18:45:22.470222Z","steps":["trace[672069395] 'count revisions from in-memory index tree' (duration: 532.570059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:22.470311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:21.937318Z","time spent":"532.97641ms","remote":"127.0.0.1:54744","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-06-23T18:45:22.619143Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053564086145705,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T18:45:22.666442Z","caller":"traceutil/trace.go:171","msg":"trace[1592335444] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"548.293553ms","start":"2026-06-23T18:45:22.118125Z","end":"2026-06-23T18:45:22.666419Z","steps":["trace[1592335444] 'read index received' (duration: 548.076557ms)","trace[1592335444] 'applied index is now lower than readState.Index' (duration: 216.136µs)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:22.666705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.5555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T18:45:22.666805Z","caller":"traceutil/trace.go:171","msg":"trace[1578591720] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1322; }","duration":"548.710415ms","start":"2026-06-23T18:45:22.118077Z","end":"2026-06-23T18:45:22.666788Z","steps":["trace[1578591720] 'agreement among raft nodes before linearized reading' (duration: 548.51536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:22.666894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:22.118057Z","time spent":"548.822067ms","remote":"127.0.0.1:54836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"warn","ts":"2026-06-23T18:45:22.666928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.143902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-23T18:45:22.666931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.072289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T18:45:22.666984Z","caller":"traceutil/trace.go:171","msg":"trace[1740154251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1322; }","duration":"404.255285ms","start":"2026-06-23T18:45:22.262717Z","end":"2026-06-23T18:45:22.666972Z","steps":["trace[1740154251] 'agreement among raft nodes before linearized reading' (duration: 404.091251ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:22.666997Z","caller":"traceutil/trace.go:171","msg":"trace[799482978] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1322; }","duration":"283.1825ms","start":"2026-06-23T18:45:22.383801Z","end":"2026-06-23T18:45:22.666983Z","steps":["trace[799482978] 'agreement among raft nodes before linearized reading' (duration: 283.043267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:22.667034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:22.262697Z","time spent":"404.325898ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-23T18:45:22.667255Z","caller":"traceutil/trace.go:171","msg":"trace[122210726] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"629.787814ms","start":"2026-06-23T18:45:22.037454Z","end":"2026-06-23T18:45:22.667242Z","steps":["trace[122210726] 'process raft request' (duration: 628.817187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:22.667418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:22.03743Z","time spent":"629.898558ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:45:27.319715Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053564086145766,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-23T18:45:27.889904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.084876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:27.889988Z","caller":"traceutil/trace.go:171","msg":"trace[1789745624] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"1.075082132s","start":"2026-06-23T18:45:26.814891Z","end":"2026-06-23T18:45:27.889973Z","steps":["trace[1789745624] 'process raft request' (duration: 828.858752ms)","trace[1789745624] 'compare' (duration: 246.003784ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:27.890063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:26.814872Z","time spent":"1.075172456s","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:45:27.914324Z","caller":"traceutil/trace.go:171","msg":"trace[333685921] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1413; }","duration":"1.094784266s","start":"2026-06-23T18:45:26.819529Z","end":"2026-06-23T18:45:27.914313Z","steps":["trace[333685921] 'read index received' (duration: 824.159632ms)","trace[333685921] 'applied index is now lower than readState.Index' (duration: 270.623654ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:27.914401Z","caller":"traceutil/trace.go:171","msg":"trace[100600980] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"1.098612783s","start":"2026-06-23T18:45:26.81578Z","end":"2026-06-23T18:45:27.914393Z","steps":["trace[100600980] 'process raft request' (duration: 1.09850381s)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:27.914376Z","caller":"traceutil/trace.go:171","msg":"trace[675786109] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"1.098705877s","start":"2026-06-23T18:45:26.815635Z","end":"2026-06-23T18:45:27.914341Z","steps":["trace[675786109] 'process raft request' (duration: 1.098586803s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:27.914444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:26.815772Z","time spent":"1.098643233s","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:45:27.914545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:26.815607Z","time spent":"1.0988508s","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:45:27.914634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.086944271s","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-06-23T18:45:27.914662Z","caller":"traceutil/trace.go:171","msg":"trace[1412599541] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1358; }","duration":"1.086989892s","start":"2026-06-23T18:45:26.827664Z","end":"2026-06-23T18:45:27.914654Z","steps":["trace[1412599541] 'agreement among raft nodes before linearized reading' (duration: 1.08691996s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:27.914682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:26.827653Z","time spent":"1.087024683s","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-23T18:45:27.914564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.095035264s","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-06-23T18:45:27.914766Z","caller":"traceutil/trace.go:171","msg":"trace[260260218] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1358; }","duration":"1.09525702s","start":"2026-06-23T18:45:26.819492Z","end":"2026-06-23T18:45:27.914749Z","steps":["trace[260260218] 'agreement among raft nodes before linearized reading' (duration: 1.095006074s)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:27.914791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.464434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:45:27.914813Z","caller":"traceutil/trace.go:171","msg":"trace[1482056367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1358; }","duration":"630.519775ms","start":"2026-06-23T18:45:27.284287Z","end":"2026-06-23T18:45:27.914807Z","steps":["trace[1482056367] 'agreement among raft nodes before linearized reading' (duration: 630.485004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:27.914829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:27.284268Z","time spent":"630.558506ms","remote":"127.0.0.1:54656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-23T18:45:27.914829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:26.819484Z","time spent":"1.095328953s","remote":"127.0.0.1:54928","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-06-23T18:45:27.91476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.691991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:45:27.914946Z","caller":"traceutil/trace.go:171","msg":"trace[1616445497] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1358; }","duration":"579.936388ms","start":"2026-06-23T18:45:27.335003Z","end":"2026-06-23T18:45:27.914939Z","steps":["trace[1616445497] 'agreement among raft nodes before linearized reading' (duration: 579.701222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:27.914971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:27.334984Z","time spent":"579.979178ms","remote":"127.0.0.1:54798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-23T18:45:28.157753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.463166ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:28.1579Z","caller":"traceutil/trace.go:171","msg":"trace[1864322357] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"239.444594ms","start":"2026-06-23T18:45:27.918413Z","end":"2026-06-23T18:45:28.157858Z","steps":["trace[1864322357] 'process raft request' (duration: 109.793323ms)","trace[1864322357] 'compare' (duration: 128.861598ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:28.684617Z","caller":"traceutil/trace.go:171","msg":"trace[690245777] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1420; }","duration":"150.852097ms","start":"2026-06-23T18:45:28.533741Z","end":"2026-06-23T18:45:28.684593Z","steps":["trace[690245777] 'read index received' (duration: 150.788025ms)","trace[690245777] 'applied index is now lower than readState.Index' (duration: 63.102µs)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:28.684714Z","caller":"traceutil/trace.go:171","msg":"trace[48300200] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"155.912096ms","start":"2026-06-23T18:45:28.528719Z","end":"2026-06-23T18:45:28.684632Z","steps":["trace[48300200] 'process raft request' (duration: 155.722781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:28.684806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.043761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-23T18:45:28.685005Z","caller":"traceutil/trace.go:171","msg":"trace[38603869] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1362; }","duration":"151.273917ms","start":"2026-06-23T18:45:28.533717Z","end":"2026-06-23T18:45:28.684991Z","steps":["trace[38603869] 'agreement among raft nodes before linearized reading' (duration: 150.965419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:29.341661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.985462ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:29.341924Z","caller":"traceutil/trace.go:171","msg":"trace[1147826893] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"525.214506ms","start":"2026-06-23T18:45:28.816682Z","end":"2026-06-23T18:45:29.341896Z","steps":["trace[1147826893] 'process raft request' (duration: 252.782041ms)","trace[1147826893] 'compare' (duration: 271.700054ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:29.342162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:28.816654Z","time spent":"525.35774ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:45:29.813871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.563687ms","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-06-23T18:45:29.813923Z","caller":"traceutil/trace.go:171","msg":"trace[893611998] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1363; }","duration":"180.673151ms","start":"2026-06-23T18:45:29.633237Z","end":"2026-06-23T18:45:29.81391Z","steps":["trace[893611998] 'count revisions from in-memory index tree' (duration: 180.489075ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:30.118327Z","caller":"traceutil/trace.go:171","msg":"trace[1402885491] linearizableReadLoop","detail":"{readStateIndex:1425; appliedIndex:1423; }","duration":"170.845648ms","start":"2026-06-23T18:45:29.947455Z","end":"2026-06-23T18:45:30.118301Z","steps":["trace[1402885491] 'read index received' (duration: 34.868993ms)","trace[1402885491] 'applied index is now lower than readState.Index' (duration: 135.975405ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:30.118406Z","caller":"traceutil/trace.go:171","msg":"trace[1567565491] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"181.559355ms","start":"2026-06-23T18:45:29.936823Z","end":"2026-06-23T18:45:30.118383Z","steps":["trace[1567565491] 'process raft request' (duration: 104.331372ms)","trace[1567565491] 'compare' (duration: 76.916344ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:30.118498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.026413ms","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-06-23T18:45:30.118572Z","caller":"traceutil/trace.go:171","msg":"trace[2106238372] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1366; }","duration":"171.140197ms","start":"2026-06-23T18:45:29.947401Z","end":"2026-06-23T18:45:30.118541Z","steps":["trace[2106238372] 'agreement among raft nodes before linearized reading' (duration: 171.036885ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:30.118635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.628656ms","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-06-23T18:45:30.118665Z","caller":"traceutil/trace.go:171","msg":"trace[1209527746] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1366; }","duration":"164.684979ms","start":"2026-06-23T18:45:29.95397Z","end":"2026-06-23T18:45:30.118655Z","steps":["trace[1209527746] 'agreement among raft nodes before linearized reading' (duration: 164.567375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:30.471028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.395099ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:30.471181Z","caller":"traceutil/trace.go:171","msg":"trace[685199539] linearizableReadLoop","detail":"{readStateIndex:1426; appliedIndex:1425; }","duration":"309.614752ms","start":"2026-06-23T18:45:30.161553Z","end":"2026-06-23T18:45:30.471168Z","steps":["trace[685199539] 'read index received' (duration: 115.046817ms)","trace[685199539] 'applied index is now lower than readState.Index' (duration: 194.567165ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:30.471276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.721874ms","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-06-23T18:45:30.471251Z","caller":"traceutil/trace.go:171","msg":"trace[774840357] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"348.700531ms","start":"2026-06-23T18:45:30.122504Z","end":"2026-06-23T18:45:30.471205Z","steps":["trace[774840357] 'process raft request' (duration: 154.067046ms)","trace[774840357] 'compare' (duration: 194.296766ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:30.471421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:30.122484Z","time spent":"348.855846ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-23T18:45:30.471306Z","caller":"traceutil/trace.go:171","msg":"trace[1547916707] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1367; }","duration":"309.775725ms","start":"2026-06-23T18:45:30.161524Z","end":"2026-06-23T18:45:30.4713Z","steps":["trace[1547916707] 'agreement among raft nodes before linearized reading' (duration: 309.685522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:30.471587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:30.161509Z","time spent":"310.039733ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-23T18:45:30.648478Z","caller":"traceutil/trace.go:171","msg":"trace[1381845544] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"172.225857ms","start":"2026-06-23T18:45:30.476208Z","end":"2026-06-23T18:45:30.648434Z","steps":["trace[1381845544] 'process raft request' (duration: 138.411833ms)","trace[1381845544] 'compare' (duration: 33.566337ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:30.648665Z","caller":"traceutil/trace.go:171","msg":"trace[60463588] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"133.9575ms","start":"2026-06-23T18:45:30.514676Z","end":"2026-06-23T18:45:30.648634Z","steps":["trace[60463588] 'process raft request' (duration: 133.647382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:45:30.953877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.582208ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:30.954051Z","caller":"traceutil/trace.go:171","msg":"trace[1060026582] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"241.301965ms","start":"2026-06-23T18:45:30.712735Z","end":"2026-06-23T18:45:30.954037Z","steps":["trace[1060026582] 'process raft request' (duration: 241.253974ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:30.954123Z","caller":"traceutil/trace.go:171","msg":"trace[1455048516] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"301.734784ms","start":"2026-06-23T18:45:30.652358Z","end":"2026-06-23T18:45:30.954092Z","steps":["trace[1455048516] 'process raft request' (duration: 120.8801ms)","trace[1455048516] 'compare' (duration: 180.455243ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:30.954244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:45:30.652328Z","time spent":"301.859067ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-23T18:45:31.234665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.355107ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:45:31.234784Z","caller":"traceutil/trace.go:171","msg":"trace[398987164] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"274.895491ms","start":"2026-06-23T18:45:30.959876Z","end":"2026-06-23T18:45:31.234772Z","steps":["trace[398987164] 'process raft request' (duration: 274.866761ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:31.234797Z","caller":"traceutil/trace.go:171","msg":"trace[1391403217] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"277.056291ms","start":"2026-06-23T18:45:30.957715Z","end":"2026-06-23T18:45:31.234772Z","steps":["trace[1391403217] 'process raft request' (duration: 128.54647ms)","trace[1391403217] 'compare' (duration: 148.257875ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:31.234911Z","caller":"traceutil/trace.go:171","msg":"trace[955766941] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1430; }","duration":"277.096223ms","start":"2026-06-23T18:45:30.957805Z","end":"2026-06-23T18:45:31.234901Z","steps":["trace[955766941] 'read index received' (duration: 128.472348ms)","trace[955766941] 'applied index is now lower than readState.Index' (duration: 148.622735ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:45:31.235066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.250468ms","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-06-23T18:45:31.235098Z","caller":"traceutil/trace.go:171","msg":"trace[862339412] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1373; }","duration":"277.313819ms","start":"2026-06-23T18:45:30.957775Z","end":"2026-06-23T18:45:31.235089Z","steps":["trace[862339412] 'agreement among raft nodes before linearized reading' (duration: 277.170736ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:36.805221Z","caller":"traceutil/trace.go:171","msg":"trace[1206725714] transaction","detail":"{read_only:false; response_revision:1402; number_of_response:1; }","duration":"118.4399ms","start":"2026-06-23T18:45:36.686748Z","end":"2026-06-23T18:45:36.805188Z","steps":["trace[1206725714] 'process raft request' (duration: 118.297606ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:37.53508Z","caller":"traceutil/trace.go:171","msg":"trace[1979848224] transaction","detail":"{read_only:false; response_revision:1403; number_of_response:1; }","duration":"146.676791ms","start":"2026-06-23T18:45:37.388375Z","end":"2026-06-23T18:45:37.535051Z","steps":["trace[1979848224] 'process raft request' (duration: 146.444584ms)"],"step_count":1} {"level":"info","ts":"2026-06-23T18:45:38.680417Z","caller":"traceutil/trace.go:171","msg":"trace[1368157818] transaction","detail":"{read_only:false; response_revision:1408; number_of_response:1; }","duration":"160.870713ms","start":"2026-06-23T18:45:38.519515Z","end":"2026-06-23T18:45:38.680386Z","steps":["trace[1368157818] 'process raft request' (duration: 140.566572ms)","trace[1368157818] 'compare' (duration: 20.064784ms)"],"step_count":2} {"level":"info","ts":"2026-06-23T18:45:44.757134Z","caller":"traceutil/trace.go:171","msg":"trace[1358041722] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"141.788877ms","start":"2026-06-23T18:45:44.615307Z","end":"2026-06-23T18:45:44.757096Z","steps":["trace[1358041722] 'process raft request' (duration: 141.480188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:49:27.671814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.401597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-23T18:49:27.671941Z","caller":"traceutil/trace.go:171","msg":"trace[1237930824] transaction","detail":"{read_only:false; response_revision:2506; number_of_response:1; }","duration":"367.08813ms","start":"2026-06-23T18:49:27.304832Z","end":"2026-06-23T18:49:27.67192Z","steps":["trace[1237930824] 'process raft request' (duration: 148.418666ms)","trace[1237930824] 'compare' (duration: 218.310064ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:49:27.672005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:49:27.304819Z","time spent":"367.155103ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:49:28.011611Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11656053564086148586,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-23T18:49:28.106217Z","caller":"traceutil/trace.go:171","msg":"trace[1516896582] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"801.074917ms","start":"2026-06-23T18:49:27.305107Z","end":"2026-06-23T18:49:28.106182Z","steps":["trace[1516896582] 'process raft request' (duration: 731.867687ms)","trace[1516896582] 'compare' (duration: 68.594453ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:49:28.106295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.96565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-23T18:49:28.106394Z","caller":"traceutil/trace.go:171","msg":"trace[1102557402] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:2507; }","duration":"595.066683ms","start":"2026-06-23T18:49:27.511262Z","end":"2026-06-23T18:49:28.106329Z","steps":["trace[1102557402] 'agreement among raft nodes before linearized reading' (duration: 594.96673ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:49:28.106398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:49:27.305084Z","time spent":"801.224311ms","remote":"127.0.0.1:54928","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-23T18:49:28.106498Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:49:27.511243Z","time spent":"595.191788ms","remote":"127.0.0.1:54880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-06-23T18:49:28.106172Z","caller":"traceutil/trace.go:171","msg":"trace[1173504153] linearizableReadLoop","detail":"{readStateIndex:2614; appliedIndex:2613; }","duration":"594.818086ms","start":"2026-06-23T18:49:27.511306Z","end":"2026-06-23T18:49:28.106124Z","steps":["trace[1173504153] 'read index received' (duration: 525.682658ms)","trace[1173504153] 'applied index is now lower than readState.Index' (duration: 69.133828ms)"],"step_count":2} {"level":"warn","ts":"2026-06-23T18:49:28.106921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.771721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-23T18:49:28.106965Z","caller":"traceutil/trace.go:171","msg":"trace[1330531722] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:2507; }","duration":"415.882764ms","start":"2026-06-23T18:49:27.691071Z","end":"2026-06-23T18:49:28.106954Z","steps":["trace[1330531722] 'agreement among raft nodes before linearized reading' (duration: 415.782921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:49:28.107031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-23T18:49:27.691051Z","time spent":"415.968145ms","remote":"127.0.0.1:55108","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-23T18:49:28.107136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.783454ms","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-06-23T18:49:28.107186Z","caller":"traceutil/trace.go:171","msg":"trace[1377848257] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2507; }","duration":"162.873867ms","start":"2026-06-23T18:49:27.9443Z","end":"2026-06-23T18:49:28.107174Z","steps":["trace[1377848257] 'agreement among raft nodes before linearized reading' (duration: 162.781275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-23T18:49:28.107212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.376604ms","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-06-23T18:49:28.107306Z","caller":"traceutil/trace.go:171","msg":"trace[764204492] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2507; }","duration":"281.482657ms","start":"2026-06-23T18:49:27.825782Z","end":"2026-06-23T18:49:28.107265Z","steps":["trace[764204492] 'agreement among raft nodes before linearized reading' (duration: 281.376474ms)"],"step_count":1}