{"level":"warn","ts":"2026-05-11T10:42:09.360874Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:42:09.360959Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-11T10:42:09.361122Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-11T10:42:09.361138Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-11T10:42:09.361154Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-11T10:42:09.361848Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-05-11T10:42:09.361921Z","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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-11T10:42:09.36672Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.507906ms"} {"level":"info","ts":"2026-05-11T10:42:09.373066Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-05-11T10:42:09.373138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-05-11T10:42:09.373178Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-05-11T10:42:09.373205Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-11T10:42:09.37323Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-05-11T10:42:09.373301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-05-11T10:42:09.380828Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-11T10:42:09.382385Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-11T10:42:09.383829Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-11T10:42:09.388213Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-11T10:42:09.388594Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-11T10:42:09.388706Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-11T10:42:09.388726Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-11T10:42:09.388812Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-11T10:42:09.391774Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-05-11T10:42:09.392025Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-05-11T10:42:09.39495Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-11T10:42:09.395165Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-11T10:42:09.395196Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-11T10:42:09.395041Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-11T10:42:09.396002Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-05-11T10:42:09.674188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-05-11T10:42:09.674251Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-11T10:42:09.674286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-05-11T10:42:09.674308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-05-11T10:42:09.67432Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-11T10:42:09.674344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-05-11T10:42:09.674364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-05-11T10:42:09.675382Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:42:09.676266Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-11T10:42:09.676428Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:42:09.676533Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-11T10:42:09.676755Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-11T10:42:09.676829Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-11T10:42:09.680611Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-05-11T10:42:09.68091Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:42:09.681074Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:42:09.681159Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-11T10:42:09.68267Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-11T10:42:34.036828Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"463.080521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-11T10:42:34.036895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.323015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-11T10:42:34.0369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.684315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T10:42:34.036942Z","caller":"traceutil/trace.go:171","msg":"trace[2039179029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:458; }","duration":"463.266192ms","start":"2026-05-11T10:42:33.573657Z","end":"2026-05-11T10:42:34.036923Z","steps":["trace[2039179029] 'range keys from in-memory index tree' (duration: 463.00382ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:34.036965Z","caller":"traceutil/trace.go:171","msg":"trace[48239606] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:458; }","duration":"553.419925ms","start":"2026-05-11T10:42:33.483526Z","end":"2026-05-11T10:42:34.036946Z","steps":["trace[48239606] 'range keys from in-memory index tree' (duration: 553.257834ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:34.036985Z","caller":"traceutil/trace.go:171","msg":"trace[1488731538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:458; }","duration":"554.812235ms","start":"2026-05-11T10:42:33.482153Z","end":"2026-05-11T10:42:34.036965Z","steps":["trace[1488731538] 'range keys from in-memory index tree' (duration: 554.582723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:34.037002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:33.483521Z","time spent":"553.473666ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-11T10:42:34.037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:33.573646Z","time spent":"463.344253ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-11T10:42:34.037042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:33.482108Z","time spent":"554.924536ms","remote":"127.0.0.1:55634","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-05-11T10:42:40.244489Z","caller":"traceutil/trace.go:171","msg":"trace[980777798] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"136.180239ms","start":"2026-05-11T10:42:40.108284Z","end":"2026-05-11T10:42:40.244464Z","steps":["trace[980777798] 'process raft request' (duration: 136.026938ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:40.244964Z","caller":"traceutil/trace.go:171","msg":"trace[200962948] linearizableReadLoop","detail":"{readStateIndex:526; appliedIndex:526; }","duration":"136.257119ms","start":"2026-05-11T10:42:40.108691Z","end":"2026-05-11T10:42:40.244948Z","steps":["trace[200962948] 'read index received' (duration: 136.251869ms)","trace[200962948] 'applied index is now lower than readState.Index' (duration: 4.23µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:42:40.245079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.367539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-11T10:42:40.245117Z","caller":"traceutil/trace.go:171","msg":"trace[826479027] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:507; }","duration":"136.42899ms","start":"2026-05-11T10:42:40.108677Z","end":"2026-05-11T10:42:40.245106Z","steps":["trace[826479027] 'agreement among raft nodes before linearized reading' (duration: 136.346419ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:40.319101Z","caller":"traceutil/trace.go:171","msg":"trace[128021741] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"208.365105ms","start":"2026-05-11T10:42:40.110529Z","end":"2026-05-11T10:42:40.318894Z","steps":["trace[128021741] 'process raft request' (duration: 205.529157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:40.320368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.500771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:40.320449Z","caller":"traceutil/trace.go:171","msg":"trace[66229288] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:509; }","duration":"121.641762ms","start":"2026-05-11T10:42:40.198777Z","end":"2026-05-11T10:42:40.320418Z","steps":["trace[66229288] 'agreement among raft nodes before linearized reading' (duration: 120.118092ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.098868Z","caller":"traceutil/trace.go:171","msg":"trace[918359690] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"428.617526ms","start":"2026-05-11T10:42:40.670226Z","end":"2026-05-11T10:42:41.098843Z","steps":["trace[918359690] 'process raft request' (duration: 419.742198ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.099379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.670198Z","time spent":"428.730887ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:42:41.15508Z","caller":"traceutil/trace.go:171","msg":"trace[974751767] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"471.82957ms","start":"2026-05-11T10:42:40.683232Z","end":"2026-05-11T10:42:41.155061Z","steps":["trace[974751767] 'process raft request' (duration: 471.610978ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.155062Z","caller":"traceutil/trace.go:171","msg":"trace[543547049] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"471.90072ms","start":"2026-05-11T10:42:40.68306Z","end":"2026-05-11T10:42:41.15496Z","steps":["trace[543547049] 'process raft request' (duration: 471.583148ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.155197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.683224Z","time spent":"471.91998ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:42:41.155193Z","caller":"traceutil/trace.go:171","msg":"trace[874856172] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"461.857104ms","start":"2026-05-11T10:42:40.693296Z","end":"2026-05-11T10:42:41.155153Z","steps":["trace[874856172] 'process raft request' (duration: 461.729364ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.155352Z","caller":"traceutil/trace.go:171","msg":"trace[1278509863] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"467.007149ms","start":"2026-05-11T10:42:40.688333Z","end":"2026-05-11T10:42:41.15534Z","steps":["trace[1278509863] 'process raft request' (duration: 466.587596ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.155615Z","caller":"traceutil/trace.go:171","msg":"trace[767741383] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"461.675273ms","start":"2026-05-11T10:42:40.693911Z","end":"2026-05-11T10:42:41.155586Z","steps":["trace[767741383] 'process raft request' (duration: 461.19384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.155628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.683039Z","time spent":"472.133811ms","remote":"127.0.0.1:55940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:42:41.155685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.688327Z","time spent":"467.083239ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:42:41.155686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.693903Z","time spent":"461.748673ms","remote":"127.0.0.1:55940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:42:41.155184Z","caller":"traceutil/trace.go:171","msg":"trace[1968043181] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"461.691113ms","start":"2026-05-11T10:42:40.693453Z","end":"2026-05-11T10:42:41.155144Z","steps":["trace[1968043181] 'process raft request' (duration: 461.614173ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.155636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.693288Z","time spent":"461.997975ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:42:41.156099Z","caller":"traceutil/trace.go:171","msg":"trace[638974545] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"452.949045ms","start":"2026-05-11T10:42:40.703137Z","end":"2026-05-11T10:42:41.156086Z","steps":["trace[638974545] 'process raft request' (duration: 452.443042ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.156073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.693447Z","time spent":"462.423928ms","remote":"127.0.0.1:55940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:42:41.156171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.70313Z","time spent":"453.009415ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:42:41.156312Z","caller":"traceutil/trace.go:171","msg":"trace[637592150] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"452.505043ms","start":"2026-05-11T10:42:40.70379Z","end":"2026-05-11T10:42:41.156295Z","steps":["trace[637592150] 'process raft request' (duration: 452.014179ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.156384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.703785Z","time spent":"452.567354ms","remote":"127.0.0.1:55940","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:42:41.162476Z","caller":"traceutil/trace.go:171","msg":"trace[1187096301] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"314.16095ms","start":"2026-05-11T10:42:40.848292Z","end":"2026-05-11T10:42:41.162453Z","steps":["trace[1187096301] 'process raft request' (duration: 314.086309ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.163346Z","caller":"traceutil/trace.go:171","msg":"trace[1176304970] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"451.009113ms","start":"2026-05-11T10:42:40.712315Z","end":"2026-05-11T10:42:41.163324Z","steps":["trace[1176304970] 'process raft request' (duration: 449.669305ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.1635Z","caller":"traceutil/trace.go:171","msg":"trace[39002932] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"427.82102ms","start":"2026-05-11T10:42:40.73563Z","end":"2026-05-11T10:42:41.163451Z","steps":["trace[39002932] 'process raft request' (duration: 426.649793ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.163589Z","caller":"traceutil/trace.go:171","msg":"trace[1749537990] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"457.730287ms","start":"2026-05-11T10:42:40.70585Z","end":"2026-05-11T10:42:41.16358Z","steps":["trace[1749537990] 'process raft request' (duration: 450.065846ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:41.163594Z","caller":"traceutil/trace.go:171","msg":"trace[1042868000] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"443.800504ms","start":"2026-05-11T10:42:40.71975Z","end":"2026-05-11T10:42:41.163551Z","steps":["trace[1042868000] 'process raft request' (duration: 442.361746ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.163688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.705829Z","time spent":"457.803077ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:42:41.163696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.719724Z","time spent":"443.934675ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:42:41.163697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.73562Z","time spent":"427.970781ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:42:41.163444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.712311Z","time spent":"451.090854ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:42:41.163311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.848247Z","time spent":"314.30087ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:42:41.163538Z","caller":"traceutil/trace.go:171","msg":"trace[1212391842] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"434.01344ms","start":"2026-05-11T10:42:40.729501Z","end":"2026-05-11T10:42:41.163515Z","steps":["trace[1212391842] 'process raft request' (duration: 432.684552ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.163983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.729468Z","time spent":"434.494933ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-11T10:42:41.164077Z","caller":"traceutil/trace.go:171","msg":"trace[1543085888] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"451.851698ms","start":"2026-05-11T10:42:40.712213Z","end":"2026-05-11T10:42:41.164065Z","steps":["trace[1543085888] 'process raft request' (duration: 449.687024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:41.164297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:40.712203Z","time spent":"451.925298ms","remote":"127.0.0.1:55430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:42:44.384164Z","caller":"traceutil/trace.go:171","msg":"trace[677281471] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"114.866592ms","start":"2026-05-11T10:42:44.269258Z","end":"2026-05-11T10:42:44.384124Z","steps":["trace[677281471] 'process raft request' (duration: 114.603698ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:44.857796Z","caller":"traceutil/trace.go:171","msg":"trace[2090041753] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:616; }","duration":"509.505423ms","start":"2026-05-11T10:42:44.34826Z","end":"2026-05-11T10:42:44.857765Z","steps":["trace[2090041753] 'read index received' (duration: 35.644195ms)","trace[2090041753] 'applied index is now lower than readState.Index' (duration: 473.860328ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:42:44.857951Z","caller":"traceutil/trace.go:171","msg":"trace[971545008] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"569.599305ms","start":"2026-05-11T10:42:44.288289Z","end":"2026-05-11T10:42:44.857888Z","steps":["trace[971545008] 'process raft request' (duration: 569.108239ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:44.858087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.809339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T10:42:44.858134Z","caller":"traceutil/trace.go:171","msg":"trace[545392208] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:596; }","duration":"509.929096ms","start":"2026-05-11T10:42:44.348194Z","end":"2026-05-11T10:42:44.858123Z","steps":["trace[545392208] 'agreement among raft nodes before linearized reading' (duration: 509.776438ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:44.858149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:44.288262Z","time spent":"569.799905ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036023,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:42:44.858176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:44.348166Z","time spent":"510.001209ms","remote":"127.0.0.1:55634","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-05-11T10:42:44.85841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.088096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:42:44.858525Z","caller":"traceutil/trace.go:171","msg":"trace[1122807219] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:596; }","duration":"507.307538ms","start":"2026-05-11T10:42:44.351189Z","end":"2026-05-11T10:42:44.858496Z","steps":["trace[1122807219] 'agreement among raft nodes before linearized reading' (duration: 507.045324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:44.858592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:44.351159Z","time spent":"507.419374ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-11T10:42:47.769165Z","caller":"traceutil/trace.go:171","msg":"trace[784922989] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"258.773716ms","start":"2026-05-11T10:42:47.510343Z","end":"2026-05-11T10:42:47.769117Z","steps":["trace[784922989] 'process raft request' (duration: 258.573566ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:48.323093Z","caller":"traceutil/trace.go:171","msg":"trace[1185765304] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"586.285798ms","start":"2026-05-11T10:42:47.736784Z","end":"2026-05-11T10:42:48.32307Z","steps":["trace[1185765304] 'process raft request' (duration: 585.770053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:48.323238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:47.736756Z","time spent":"586.406105ms","remote":"127.0.0.1:55474","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:42:48.390585Z","caller":"traceutil/trace.go:171","msg":"trace[1362583164] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"596.20015ms","start":"2026-05-11T10:42:47.794295Z","end":"2026-05-11T10:42:48.390495Z","steps":["trace[1362583164] 'process raft request' (duration: 595.99201ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:48.390915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:47.794274Z","time spent":"596.430021ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:42:48.92869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.110581ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-11T10:42:48.928942Z","caller":"traceutil/trace.go:171","msg":"trace[1142828666] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"528.267839ms","start":"2026-05-11T10:42:48.400638Z","end":"2026-05-11T10:42:48.928906Z","steps":["trace[1142828666] 'process raft request' (duration: 528.156564ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:48.92909Z","caller":"traceutil/trace.go:171","msg":"trace[1234955131] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:639; }","duration":"685.143732ms","start":"2026-05-11T10:42:48.243919Z","end":"2026-05-11T10:42:48.929063Z","steps":["trace[1234955131] 'read index received' (duration: 78.523501ms)","trace[1234955131] 'applied index is now lower than readState.Index' (duration: 606.614941ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:42:48.929213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:48.400623Z","time spent":"528.357174ms","remote":"127.0.0.1:55908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-11T10:42:48.929392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.748863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T10:42:48.929464Z","caller":"traceutil/trace.go:171","msg":"trace[297151995] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"528.861759ms","start":"2026-05-11T10:42:48.400583Z","end":"2026-05-11T10:42:48.929444Z","steps":["trace[297151995] 'agreement among raft nodes before linearized reading' (duration: 528.644488ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:48.929499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:48.400565Z","time spent":"528.926191ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-11T10:42:48.930074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.135711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:48.930095Z","caller":"traceutil/trace.go:171","msg":"trace[670959249] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"686.222656ms","start":"2026-05-11T10:42:48.243867Z","end":"2026-05-11T10:42:48.930089Z","steps":["trace[670959249] 'agreement among raft nodes before linearized reading' (duration: 685.315861ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:48.930115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:48.243845Z","time spent":"686.266608ms","remote":"127.0.0.1:55388","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-05-11T10:42:49.43774Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114272705667595,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-11T10:42:49.579078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.74999ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:42:49.579339Z","caller":"traceutil/trace.go:171","msg":"trace[1593981237] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:643; }","duration":"642.567639ms","start":"2026-05-11T10:42:48.93675Z","end":"2026-05-11T10:42:49.579318Z","steps":["trace[1593981237] 'read index received' (duration: 536.878743ms)","trace[1593981237] 'applied index is now lower than readState.Index' (duration: 105.687676ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:42:49.579371Z","caller":"traceutil/trace.go:171","msg":"trace[982713297] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"643.441862ms","start":"2026-05-11T10:42:48.935886Z","end":"2026-05-11T10:42:49.579327Z","steps":["trace[982713297] 'process raft request' (duration: 537.322254ms)","trace[982713297] 'compare' (duration: 104.770582ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:42:49.579429Z","caller":"traceutil/trace.go:171","msg":"trace[58818350] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"642.025751ms","start":"2026-05-11T10:42:48.937362Z","end":"2026-05-11T10:42:49.579388Z","steps":["trace[58818350] 'process raft request' (duration: 641.850763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:49.579464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.706746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:49.579525Z","caller":"traceutil/trace.go:171","msg":"trace[213238957] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:623; }","duration":"642.7808ms","start":"2026-05-11T10:42:48.936732Z","end":"2026-05-11T10:42:49.579513Z","steps":["trace[213238957] 'agreement among raft nodes before linearized reading' (duration: 642.655933ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:42:49.579452Z","caller":"traceutil/trace.go:171","msg":"trace[432700312] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"641.486345ms","start":"2026-05-11T10:42:48.937909Z","end":"2026-05-11T10:42:49.579395Z","steps":["trace[432700312] 'process raft request' (duration: 641.365739ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:49.579579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:48.936725Z","time spent":"642.843582ms","remote":"127.0.0.1:55614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-11T10:42:49.579579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:48.935872Z","time spent":"643.58415ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:42:49.579621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:48.937352Z","time spent":"642.173399ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:42:49.579681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:42:48.937899Z","time spent":"641.680115ms","remote":"127.0.0.1:55634","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-05-11T10:42:51.042334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.315456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.042421Z","caller":"traceutil/trace.go:171","msg":"trace[1654115450] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:641; }","duration":"215.451422ms","start":"2026-05-11T10:42:50.826953Z","end":"2026-05-11T10:42:51.042404Z","steps":["trace[1654115450] 'range keys from in-memory index tree' (duration: 215.247332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.042578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.18339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.042625Z","caller":"traceutil/trace.go:171","msg":"trace[1555412695] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:641; }","duration":"215.256243ms","start":"2026-05-11T10:42:50.827358Z","end":"2026-05-11T10:42:51.042614Z","steps":["trace[1555412695] 'count revisions from in-memory index tree' (duration: 215.144818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.042711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.500757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.042727Z","caller":"traceutil/trace.go:171","msg":"trace[1004218228] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:641; }","duration":"214.526548ms","start":"2026-05-11T10:42:50.828195Z","end":"2026-05-11T10:42:51.042722Z","steps":["trace[1004218228] 'range keys from in-memory index tree' (duration: 214.478025ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.042791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.049717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.042805Z","caller":"traceutil/trace.go:171","msg":"trace[1070704673] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:641; }","duration":"185.083549ms","start":"2026-05-11T10:42:50.857717Z","end":"2026-05-11T10:42:51.042801Z","steps":["trace[1070704673] 'count revisions from in-memory index tree' (duration: 184.983894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.042899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.028267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.042916Z","caller":"traceutil/trace.go:171","msg":"trace[1468524918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:641; }","duration":"185.09386ms","start":"2026-05-11T10:42:50.857819Z","end":"2026-05-11T10:42:51.042913Z","steps":["trace[1468524918] 'range keys from in-memory index tree' (duration: 184.943902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.042976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.353587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.042997Z","caller":"traceutil/trace.go:171","msg":"trace[373840354] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:641; }","duration":"154.379489ms","start":"2026-05-11T10:42:50.888606Z","end":"2026-05-11T10:42:51.042985Z","steps":["trace[373840354] 'count revisions from in-memory index tree' (duration: 154.293494ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.043075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.324386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.04309Z","caller":"traceutil/trace.go:171","msg":"trace[1146378128] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:641; }","duration":"154.391609ms","start":"2026-05-11T10:42:50.888694Z","end":"2026-05-11T10:42:51.043086Z","steps":["trace[1146378128] 'range keys from in-memory index tree' (duration: 154.145327ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.043148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.949328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.043163Z","caller":"traceutil/trace.go:171","msg":"trace[571462409] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:641; }","duration":"153.974309ms","start":"2026-05-11T10:42:50.889182Z","end":"2026-05-11T10:42:51.043156Z","steps":["trace[571462409] 'range keys from in-memory index tree' (duration: 153.905665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.043275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.622749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.043289Z","caller":"traceutil/trace.go:171","msg":"trace[648388509] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:641; }","duration":"103.64893ms","start":"2026-05-11T10:42:50.939635Z","end":"2026-05-11T10:42:51.043284Z","steps":["trace[648388509] 'range keys from in-memory index tree' (duration: 103.602568ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.043366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.751365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.043378Z","caller":"traceutil/trace.go:171","msg":"trace[1485225689] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:641; }","duration":"103.764986ms","start":"2026-05-11T10:42:50.939609Z","end":"2026-05-11T10:42:51.043374Z","steps":["trace[1485225689] 'count revisions from in-memory index tree' (duration: 103.686012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:42:51.043433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.080294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:42:51.043445Z","caller":"traceutil/trace.go:171","msg":"trace[1532506502] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:641; }","duration":"102.100035ms","start":"2026-05-11T10:42:50.941341Z","end":"2026-05-11T10:42:51.043441Z","steps":["trace[1532506502] 'range keys from in-memory index tree' (duration: 102.057353ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:05.165637Z","caller":"traceutil/trace.go:171","msg":"trace[2032717798] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"376.696763ms","start":"2026-05-11T10:43:04.788916Z","end":"2026-05-11T10:43:05.165613Z","steps":["trace[2032717798] 'process raft request' (duration: 376.537936ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:05.165875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:43:04.78889Z","time spent":"376.901141ms","remote":"127.0.0.1:55614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:43:34.358985Z","caller":"traceutil/trace.go:171","msg":"trace[1368333611] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"539.602807ms","start":"2026-05-11T10:43:33.819352Z","end":"2026-05-11T10:43:34.358955Z","steps":["trace[1368333611] 'process raft request' (duration: 539.38458ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:34.359238Z","caller":"traceutil/trace.go:171","msg":"trace[1103863272] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"539.862124ms","start":"2026-05-11T10:43:33.819354Z","end":"2026-05-11T10:43:34.359216Z","steps":["trace[1103863272] 'process raft request' (duration: 539.548885ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:34.359362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:43:33.819329Z","time spent":"539.983528ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:43:34.35932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:43:33.819335Z","time spent":"539.753521ms","remote":"127.0.0.1:55634","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-05-11T10:43:34.475663Z","caller":"traceutil/trace.go:171","msg":"trace[949083511] linearizableReadLoop","detail":"{readStateIndex:1220; appliedIndex:1216; }","duration":"393.100569ms","start":"2026-05-11T10:43:34.082537Z","end":"2026-05-11T10:43:34.475637Z","steps":["trace[949083511] 'read index received' (duration: 276.187732ms)","trace[949083511] 'applied index is now lower than readState.Index' (duration: 116.911547ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:43:34.476135Z","caller":"traceutil/trace.go:171","msg":"trace[1036227306] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"655.952556ms","start":"2026-05-11T10:43:33.820164Z","end":"2026-05-11T10:43:34.476116Z","steps":["trace[1036227306] 'process raft request' (duration: 652.707459ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:34.476129Z","caller":"traceutil/trace.go:171","msg":"trace[384220709] transaction","detail":"{read_only:false; response_revision:1185; number_of_response:1; }","duration":"416.258783ms","start":"2026-05-11T10:43:34.059832Z","end":"2026-05-11T10:43:34.476091Z","steps":["trace[384220709] 'process raft request' (duration: 415.759858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:34.47622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.656775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-11T10:43:34.476222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.643399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T10:43:34.476262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:43:33.820155Z","time spent":"656.023468ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:43:34.476277Z","caller":"traceutil/trace.go:171","msg":"trace[1030189510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1185; }","duration":"393.77256ms","start":"2026-05-11T10:43:34.082488Z","end":"2026-05-11T10:43:34.47626Z","steps":["trace[1030189510] 'agreement among raft nodes before linearized reading' (duration: 393.401639ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:34.476295Z","caller":"traceutil/trace.go:171","msg":"trace[1741516560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1185; }","duration":"231.764403ms","start":"2026-05-11T10:43:34.244509Z","end":"2026-05-11T10:43:34.476273Z","steps":["trace[1741516560] 'agreement among raft nodes before linearized reading' (duration: 231.565107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:34.476338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:43:34.082461Z","time spent":"393.864482ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-11T10:43:34.47634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:43:34.059804Z","time spent":"416.447057ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:43:50.718135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.143823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T10:43:50.718263Z","caller":"traceutil/trace.go:171","msg":"trace[2132486771] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1319; }","duration":"281.342019ms","start":"2026-05-11T10:43:50.436895Z","end":"2026-05-11T10:43:50.718237Z","steps":["trace[2132486771] 'range keys from in-memory index tree' (duration: 280.933427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:50.718609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.85515ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:43:50.718927Z","caller":"traceutil/trace.go:171","msg":"trace[1448400751] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1319; }","duration":"280.043725ms","start":"2026-05-11T10:43:50.438639Z","end":"2026-05-11T10:43:50.718683Z","steps":["trace[1448400751] 'range keys from in-memory index tree' (duration: 279.12322ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:50.723938Z","caller":"traceutil/trace.go:171","msg":"trace[1055765621] linearizableReadLoop","detail":"{readStateIndex:1363; appliedIndex:1362; }","duration":"170.174402ms","start":"2026-05-11T10:43:50.553737Z","end":"2026-05-11T10:43:50.723912Z","steps":["trace[1055765621] 'read index received' (duration: 170.127981ms)","trace[1055765621] 'applied index is now lower than readState.Index' (duration: 44.821µs)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:43:50.724103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.374487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T10:43:50.72413Z","caller":"traceutil/trace.go:171","msg":"trace[1975085175] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1320; }","duration":"170.435208ms","start":"2026-05-11T10:43:50.553686Z","end":"2026-05-11T10:43:50.724122Z","steps":["trace[1975085175] 'agreement among raft nodes before linearized reading' (duration: 170.358926ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:50.72408Z","caller":"traceutil/trace.go:171","msg":"trace[472174829] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"185.314372ms","start":"2026-05-11T10:43:50.538681Z","end":"2026-05-11T10:43:50.723996Z","steps":["trace[472174829] 'process raft request' (duration: 185.055245ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:50.729241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.324766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-11T10:43:50.729283Z","caller":"traceutil/trace.go:171","msg":"trace[468809362] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"168.369097ms","start":"2026-05-11T10:43:50.560904Z","end":"2026-05-11T10:43:50.729274Z","steps":["trace[468809362] 'agreement among raft nodes before linearized reading' (duration: 167.373401ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:58.941408Z","caller":"traceutil/trace.go:171","msg":"trace[210213774] linearizableReadLoop","detail":"{readStateIndex:1493; appliedIndex:1492; }","duration":"173.215378ms","start":"2026-05-11T10:43:58.768166Z","end":"2026-05-11T10:43:58.941382Z","steps":["trace[210213774] 'read index received' (duration: 172.993033ms)","trace[210213774] 'applied index is now lower than readState.Index' (duration: 221.085µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:43:58.941772Z","caller":"traceutil/trace.go:171","msg":"trace[350666641] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"181.61962ms","start":"2026-05-11T10:43:58.759928Z","end":"2026-05-11T10:43:58.941548Z","steps":["trace[350666641] 'process raft request' (duration: 181.247181ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:58.941946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.379334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:43:58.942056Z","caller":"traceutil/trace.go:171","msg":"trace[794091749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1447; }","duration":"171.581859ms","start":"2026-05-11T10:43:58.770454Z","end":"2026-05-11T10:43:58.942036Z","steps":["trace[794091749] 'agreement among raft nodes before linearized reading' (duration: 171.294982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:58.94201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.843714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T10:43:58.942248Z","caller":"traceutil/trace.go:171","msg":"trace[1767689799] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1447; }","duration":"174.12121ms","start":"2026-05-11T10:43:58.768111Z","end":"2026-05-11T10:43:58.942232Z","steps":["trace[1767689799] 'agreement among raft nodes before linearized reading' (duration: 173.6922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:43:58.942419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.765553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-11T10:43:58.942475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.20948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-11T10:43:58.942511Z","caller":"traceutil/trace.go:171","msg":"trace[1114208370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1447; }","duration":"171.880856ms","start":"2026-05-11T10:43:58.770608Z","end":"2026-05-11T10:43:58.942488Z","steps":["trace[1114208370] 'agreement among raft nodes before linearized reading' (duration: 171.663951ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:43:58.942563Z","caller":"traceutil/trace.go:171","msg":"trace[616778292] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1447; }","duration":"171.311622ms","start":"2026-05-11T10:43:58.771223Z","end":"2026-05-11T10:43:58.942534Z","steps":["trace[616778292] 'agreement among raft nodes before linearized reading' (duration: 171.119938ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:17.064904Z","caller":"traceutil/trace.go:171","msg":"trace[457723468] transaction","detail":"{read_only:false; response_revision:1757; number_of_response:1; }","duration":"125.032594ms","start":"2026-05-11T10:44:16.939831Z","end":"2026-05-11T10:44:17.064864Z","steps":["trace[457723468] 'process raft request' (duration: 124.763668ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.465775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.501034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:44:25.465897Z","caller":"traceutil/trace.go:171","msg":"trace[879278926] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"372.384853ms","start":"2026-05-11T10:44:25.093488Z","end":"2026-05-11T10:44:25.465873Z","steps":["trace[879278926] 'process raft request' (duration: 143.692005ms)","trace[879278926] 'compare' (duration: 228.136787ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:25.466108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:25.093456Z","time spent":"372.554127ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:25.468099Z","caller":"traceutil/trace.go:171","msg":"trace[550131485] linearizableReadLoop","detail":"{readStateIndex:1942; appliedIndex:1940; }","duration":"348.032969ms","start":"2026-05-11T10:44:25.120049Z","end":"2026-05-11T10:44:25.468082Z","steps":["trace[550131485] 'read index received' (duration: 117.104078ms)","trace[550131485] 'applied index is now lower than readState.Index' (duration: 230.927731ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:25.468413Z","caller":"traceutil/trace.go:171","msg":"trace[1664670288] transaction","detail":"{read_only:false; response_revision:1868; number_of_response:1; }","duration":"365.326695ms","start":"2026-05-11T10:44:25.10307Z","end":"2026-05-11T10:44:25.468397Z","steps":["trace[1664670288] 'process raft request' (duration: 364.945908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.468505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.36727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-11T10:44:25.46853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:25.103042Z","time spent":"365.407497ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:25.468581Z","caller":"traceutil/trace.go:171","msg":"trace[1104047164] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1868; }","duration":"340.459411ms","start":"2026-05-11T10:44:25.1281Z","end":"2026-05-11T10:44:25.46856Z","steps":["trace[1104047164] 'agreement among raft nodes before linearized reading' (duration: 340.273368ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.468619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:25.128085Z","time spent":"340.525293ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-11T10:44:25.468781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.283999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-11T10:44:25.46882Z","caller":"traceutil/trace.go:171","msg":"trace[1389991702] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1868; }","duration":"339.3474ms","start":"2026-05-11T10:44:25.129462Z","end":"2026-05-11T10:44:25.46881Z","steps":["trace[1389991702] 'agreement among raft nodes before linearized reading' (duration: 339.218238ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.468886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:25.129453Z","time spent":"339.422962ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-11T10:44:25.46902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.907026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-11T10:44:25.469217Z","caller":"traceutil/trace.go:171","msg":"trace[1606057231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1868; }","duration":"349.170092ms","start":"2026-05-11T10:44:25.119994Z","end":"2026-05-11T10:44:25.469164Z","steps":["trace[1606057231] 'agreement among raft nodes before linearized reading' (duration: 348.319005ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.469043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.508436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-28359101-46cc-4f8f-bd8a-b2f9a6657cd3\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-05-11T10:44:25.469337Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:25.11998Z","time spent":"349.342425ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-11T10:44:25.469412Z","caller":"traceutil/trace.go:171","msg":"trace[1457962684] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-28359101-46cc-4f8f-bd8a-b2f9a6657cd3; range_end:; response_count:1; response_revision:1868; }","duration":"279.083979ms","start":"2026-05-11T10:44:25.190302Z","end":"2026-05-11T10:44:25.469386Z","steps":["trace[1457962684] 'agreement among raft nodes before linearized reading' (duration: 278.184131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.469077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.054797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-28359101-46cc-4f8f-bd8a-b2f9a6657cd3\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-05-11T10:44:25.469559Z","caller":"traceutil/trace.go:171","msg":"trace[1956054986] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-28359101-46cc-4f8f-bd8a-b2f9a6657cd3; range_end:; response_count:1; response_revision:1868; }","duration":"280.560407ms","start":"2026-05-11T10:44:25.188984Z","end":"2026-05-11T10:44:25.469545Z","steps":["trace[1956054986] 'agreement among raft nodes before linearized reading' (duration: 279.831072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.469889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.656206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-11T10:44:25.47Z","caller":"traceutil/trace.go:171","msg":"trace[635582137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1868; }","duration":"341.810298ms","start":"2026-05-11T10:44:25.128164Z","end":"2026-05-11T10:44:25.469975Z","steps":["trace[635582137] 'agreement among raft nodes before linearized reading' (duration: 340.537633ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:25.470064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:25.128148Z","time spent":"341.904011ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-11T10:44:25.470132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.201744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-05-11T10:44:25.470238Z","caller":"traceutil/trace.go:171","msg":"trace[2003836628] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1868; }","duration":"220.441858ms","start":"2026-05-11T10:44:25.249776Z","end":"2026-05-11T10:44:25.470218Z","steps":["trace[2003836628] 'agreement among raft nodes before linearized reading' (duration: 219.357247ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:25.687258Z","caller":"traceutil/trace.go:171","msg":"trace[2065521158] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"160.649784ms","start":"2026-05-11T10:44:25.526564Z","end":"2026-05-11T10:44:25.687213Z","steps":["trace[2065521158] 'process raft request' (duration: 154.043896ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:26.581491Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.769968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:528"} {"level":"info","ts":"2026-05-11T10:44:26.581582Z","caller":"traceutil/trace.go:171","msg":"trace[798411275] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1880; }","duration":"480.969131ms","start":"2026-05-11T10:44:26.100591Z","end":"2026-05-11T10:44:26.58156Z","steps":["trace[798411275] 'range keys from in-memory index tree' (duration: 480.467952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:26.581622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:26.100537Z","time spent":"481.076833ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":551,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-05-11T10:44:26.582261Z","caller":"traceutil/trace.go:171","msg":"trace[829680945] linearizableReadLoop","detail":"{readStateIndex:1955; appliedIndex:1954; }","duration":"336.825266ms","start":"2026-05-11T10:44:26.245423Z","end":"2026-05-11T10:44:26.582248Z","steps":["trace[829680945] 'read index received' (duration: 336.654143ms)","trace[829680945] 'applied index is now lower than readState.Index' (duration: 169.883µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:26.582493Z","caller":"traceutil/trace.go:171","msg":"trace[480824351] transaction","detail":"{read_only:false; response_revision:1881; number_of_response:1; }","duration":"469.587682ms","start":"2026-05-11T10:44:26.112849Z","end":"2026-05-11T10:44:26.582437Z","steps":["trace[480824351] 'process raft request' (duration: 469.261136ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:26.582621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.201944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:26.58267Z","caller":"traceutil/trace.go:171","msg":"trace[1646124141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1881; }","duration":"337.277695ms","start":"2026-05-11T10:44:26.245374Z","end":"2026-05-11T10:44:26.582651Z","steps":["trace[1646124141] 'agreement among raft nodes before linearized reading' (duration: 337.212264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:26.582715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:26.112837Z","time spent":"469.744365ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:26.582756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:26.245354Z","time spent":"337.392168ms","remote":"127.0.0.1:55388","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-05-11T10:44:26.585335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.67471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-11T10:44:26.585488Z","caller":"traceutil/trace.go:171","msg":"trace[550239680] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1882; }","duration":"108.882383ms","start":"2026-05-11T10:44:26.476583Z","end":"2026-05-11T10:44:26.585465Z","steps":["trace[550239680] 'agreement among raft nodes before linearized reading' (duration: 108.619038ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:26.585982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.944893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-28359101-46cc-4f8f-bd8a-b2f9a6657cd3\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-05-11T10:44:26.586092Z","caller":"traceutil/trace.go:171","msg":"trace[242594174] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-28359101-46cc-4f8f-bd8a-b2f9a6657cd3; range_end:; response_count:1; response_revision:1882; }","duration":"111.083136ms","start":"2026-05-11T10:44:26.474984Z","end":"2026-05-11T10:44:26.586067Z","steps":["trace[242594174] 'agreement among raft nodes before linearized reading' (duration: 110.900272ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:31.636478Z","caller":"traceutil/trace.go:171","msg":"trace[452782665] linearizableReadLoop","detail":"{readStateIndex:2005; appliedIndex:2004; }","duration":"104.741736ms","start":"2026-05-11T10:44:31.531711Z","end":"2026-05-11T10:44:31.636453Z","steps":["trace[452782665] 'read index received' (duration: 80.487743ms)","trace[452782665] 'applied index is now lower than readState.Index' (duration: 24.252963ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:31.636735Z","caller":"traceutil/trace.go:171","msg":"trace[1435386739] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"127.672255ms","start":"2026-05-11T10:44:31.509049Z","end":"2026-05-11T10:44:31.636721Z","steps":["trace[1435386739] 'process raft request' (duration: 103.225678ms)","trace[1435386739] 'compare' (duration: 23.776635ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:44:31.637021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.284576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-11T10:44:31.637055Z","caller":"traceutil/trace.go:171","msg":"trace[217943753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1930; }","duration":"105.357338ms","start":"2026-05-11T10:44:31.531687Z","end":"2026-05-11T10:44:31.637044Z","steps":["trace[217943753] 'agreement among raft nodes before linearized reading' (duration: 105.217356ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:38.941584Z","caller":"traceutil/trace.go:171","msg":"trace[1349629115] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"320.872198ms","start":"2026-05-11T10:44:38.620682Z","end":"2026-05-11T10:44:38.941554Z","steps":["trace[1349629115] 'process raft request' (duration: 320.605563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:38.941778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:38.620643Z","time spent":"321.03451ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:39.014275Z","caller":"traceutil/trace.go:171","msg":"trace[138354781] linearizableReadLoop","detail":"{readStateIndex:2059; appliedIndex:2057; }","duration":"344.385997ms","start":"2026-05-11T10:44:38.669866Z","end":"2026-05-11T10:44:39.014252Z","steps":["trace[138354781] 'read index received' (duration: 271.461174ms)","trace[138354781] 'applied index is now lower than readState.Index' (duration: 72.924013ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:39.01436Z","caller":"traceutil/trace.go:171","msg":"trace[222106374] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"393.450555ms","start":"2026-05-11T10:44:38.620865Z","end":"2026-05-11T10:44:39.014316Z","steps":["trace[222106374] 'process raft request' (duration: 393.230511ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:39.014403Z","caller":"traceutil/trace.go:171","msg":"trace[1664667383] transaction","detail":"{read_only:false; response_revision:1983; number_of_response:1; }","duration":"202.662523ms","start":"2026-05-11T10:44:38.811705Z","end":"2026-05-11T10:44:39.014368Z","steps":["trace[1664667383] 'process raft request' (duration: 202.51414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:39.014504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.614001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-dg4m9\" ","response":"range_response_count:1 size:5852"} {"level":"info","ts":"2026-05-11T10:44:39.014535Z","caller":"traceutil/trace.go:171","msg":"trace[743515106] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-dg4m9; range_end:; response_count:1; response_revision:1983; }","duration":"344.707663ms","start":"2026-05-11T10:44:38.669818Z","end":"2026-05-11T10:44:39.014526Z","steps":["trace[743515106] 'agreement among raft nodes before linearized reading' (duration: 344.55252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:39.014558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:38.669802Z","time spent":"344.751083ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":5875,"request content":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-dg4m9\" "} {"level":"warn","ts":"2026-05-11T10:44:39.014579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:38.620836Z","time spent":"393.607887ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:39.014975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.2047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-11T10:44:39.015061Z","caller":"traceutil/trace.go:171","msg":"trace[1042688102] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1983; }","duration":"327.336501ms","start":"2026-05-11T10:44:38.687703Z","end":"2026-05-11T10:44:39.01504Z","steps":["trace[1042688102] 'agreement among raft nodes before linearized reading' (duration: 327.071877ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:39.015105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:38.687685Z","time spent":"327.411073ms","remote":"127.0.0.1:40538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-11T10:44:39.141139Z","caller":"traceutil/trace.go:171","msg":"trace[268339868] transaction","detail":"{read_only:false; response_revision:1984; number_of_response:1; }","duration":"116.4788ms","start":"2026-05-11T10:44:39.024633Z","end":"2026-05-11T10:44:39.141112Z","steps":["trace[268339868] 'process raft request' (duration: 101.740219ms)","trace[268339868] 'compare' (duration: 14.622679ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:39.459588Z","caller":"traceutil/trace.go:171","msg":"trace[272688002] transaction","detail":"{read_only:false; response_revision:1989; number_of_response:1; }","duration":"131.730961ms","start":"2026-05-11T10:44:39.327828Z","end":"2026-05-11T10:44:39.459559Z","steps":["trace[272688002] 'process raft request' (duration: 124.494112ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:39.459662Z","caller":"traceutil/trace.go:171","msg":"trace[1359802138] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"126.689672ms","start":"2026-05-11T10:44:39.332946Z","end":"2026-05-11T10:44:39.459636Z","steps":["trace[1359802138] 'process raft request' (duration: 126.628751ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:39.46007Z","caller":"traceutil/trace.go:171","msg":"trace[138697916] transaction","detail":"{read_only:false; response_revision:1991; number_of_response:1; }","duration":"130.005411ms","start":"2026-05-11T10:44:39.330048Z","end":"2026-05-11T10:44:39.460054Z","steps":["trace[138697916] 'process raft request' (duration: 129.480572ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:39.460446Z","caller":"traceutil/trace.go:171","msg":"trace[1022095914] transaction","detail":"{read_only:false; response_revision:1990; number_of_response:1; }","duration":"130.410218ms","start":"2026-05-11T10:44:39.330023Z","end":"2026-05-11T10:44:39.460433Z","steps":["trace[1022095914] 'process raft request' (duration: 129.426131ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:43.50561Z","caller":"traceutil/trace.go:171","msg":"trace[2134439064] linearizableReadLoop","detail":"{readStateIndex:2094; appliedIndex:2091; }","duration":"430.629684ms","start":"2026-05-11T10:44:43.074936Z","end":"2026-05-11T10:44:43.505566Z","steps":["trace[2134439064] 'read index received' (duration: 429.311931ms)","trace[2134439064] 'applied index is now lower than readState.Index' (duration: 1.314553ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:44:43.505766Z","caller":"traceutil/trace.go:171","msg":"trace[40787479] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"467.528014ms","start":"2026-05-11T10:44:43.038217Z","end":"2026-05-11T10:44:43.505745Z","steps":["trace[40787479] 'process raft request' (duration: 467.29747ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:43.505778Z","caller":"traceutil/trace.go:171","msg":"trace[49226239] transaction","detail":"{read_only:false; response_revision:2014; number_of_response:1; }","duration":"545.38962ms","start":"2026-05-11T10:44:42.960363Z","end":"2026-05-11T10:44:43.505752Z","steps":["trace[49226239] 'process raft request' (duration: 543.874854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:43.505855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.75939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T10:44:43.505909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:43.038194Z","time spent":"467.622496ms","remote":"127.0.0.1:55406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:43.505928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:42.960311Z","time spent":"545.531733ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:44:43.505929Z","caller":"traceutil/trace.go:171","msg":"trace[76458345] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2016; }","duration":"311.896653ms","start":"2026-05-11T10:44:43.194015Z","end":"2026-05-11T10:44:43.505912Z","steps":["trace[76458345] 'agreement among raft nodes before linearized reading' (duration: 311.767671ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:44:43.505934Z","caller":"traceutil/trace.go:171","msg":"trace[1749832075] transaction","detail":"{read_only:false; response_revision:2015; number_of_response:1; }","duration":"475.282759ms","start":"2026-05-11T10:44:43.030636Z","end":"2026-05-11T10:44:43.505919Z","steps":["trace[1749832075] 'process raft request' (duration: 474.812541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:43.505974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:43.193994Z","time spent":"311.968284ms","remote":"127.0.0.1:43124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-05-11T10:44:43.506062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.088918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:44:43.506089Z","caller":"traceutil/trace.go:171","msg":"trace[263204894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2016; }","duration":"262.167109ms","start":"2026-05-11T10:44:43.243913Z","end":"2026-05-11T10:44:43.506081Z","steps":["trace[263204894] 'agreement among raft nodes before linearized reading' (duration: 262.111028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:43.506104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:43.030604Z","time spent":"475.362011ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:44:43.506365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.430628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-11T10:44:43.506424Z","caller":"traceutil/trace.go:171","msg":"trace[867976775] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2016; }","duration":"431.528699ms","start":"2026-05-11T10:44:43.074878Z","end":"2026-05-11T10:44:43.506407Z","steps":["trace[867976775] 'agreement among raft nodes before linearized reading' (duration: 430.862598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:44:43.506463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:44:43.074855Z","time spent":"431.600111ms","remote":"127.0.0.1:40538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-11T10:45:00.570182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.08599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:45:00.570257Z","caller":"traceutil/trace.go:171","msg":"trace[1650701155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2116; }","duration":"326.224982ms","start":"2026-05-11T10:45:00.244015Z","end":"2026-05-11T10:45:00.57024Z","steps":["trace[1650701155] 'range keys from in-memory index tree' (duration: 325.972659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:00.570287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:00.243986Z","time spent":"326.295284ms","remote":"127.0.0.1:55388","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-05-11T10:45:00.570678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.903112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:45:00.570706Z","caller":"traceutil/trace.go:171","msg":"trace[2093267666] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2116; }","duration":"295.963462ms","start":"2026-05-11T10:45:00.274734Z","end":"2026-05-11T10:45:00.570698Z","steps":["trace[2093267666] 'count revisions from in-memory index tree' (duration: 295.838341ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:06.061393Z","caller":"traceutil/trace.go:171","msg":"trace[1793687961] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"223.757333ms","start":"2026-05-11T10:45:05.837591Z","end":"2026-05-11T10:45:06.061348Z","steps":["trace[1793687961] 'process raft request' (duration: 223.55968ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:06.124052Z","caller":"traceutil/trace.go:171","msg":"trace[941175388] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"284.573388ms","start":"2026-05-11T10:45:05.83945Z","end":"2026-05-11T10:45:06.124023Z","steps":["trace[941175388] 'process raft request' (duration: 284.256504ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:06.124442Z","caller":"traceutil/trace.go:171","msg":"trace[919348933] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"284.364415ms","start":"2026-05-11T10:45:05.840052Z","end":"2026-05-11T10:45:06.124417Z","steps":["trace[919348933] 'process raft request' (duration: 283.880938ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:06.124672Z","caller":"traceutil/trace.go:171","msg":"trace[1639299443] linearizableReadLoop","detail":"{readStateIndex:2228; appliedIndex:2224; }","duration":"117.950629ms","start":"2026-05-11T10:45:06.006703Z","end":"2026-05-11T10:45:06.124654Z","steps":["trace[1639299443] 'read index received' (duration: 54.388771ms)","trace[1639299443] 'applied index is now lower than readState.Index' (duration: 63.560308ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:06.124735Z","caller":"traceutil/trace.go:171","msg":"trace[1538094389] transaction","detail":"{read_only:false; response_revision:2146; number_of_response:1; }","duration":"284.585658ms","start":"2026-05-11T10:45:05.840143Z","end":"2026-05-11T10:45:06.124729Z","steps":["trace[1538094389] 'process raft request' (duration: 284.166332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:06.12489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.177112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-11T10:45:06.124915Z","caller":"traceutil/trace.go:171","msg":"trace[259091644] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2146; }","duration":"118.256103ms","start":"2026-05-11T10:45:06.006654Z","end":"2026-05-11T10:45:06.12491Z","steps":["trace[259091644] 'agreement among raft nodes before linearized reading' (duration: 118.142761ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:08.173328Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114272705670690,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-11T10:45:08.409195Z","caller":"traceutil/trace.go:171","msg":"trace[868411855] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"774.365404ms","start":"2026-05-11T10:45:07.634799Z","end":"2026-05-11T10:45:08.409165Z","steps":["trace[868411855] 'process raft request' (duration: 774.10532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:08.409384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:07.634774Z","time spent":"774.517916ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:08.888171Z","caller":"traceutil/trace.go:171","msg":"trace[827196724] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"1.252578718s","start":"2026-05-11T10:45:07.635559Z","end":"2026-05-11T10:45:08.888138Z","steps":["trace[827196724] 'process raft request' (duration: 1.159667099s)","trace[827196724] 'compare' (duration: 92.585005ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:08.888358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:07.635542Z","time spent":"1.25271921s","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:08.889288Z","caller":"traceutil/trace.go:171","msg":"trace[544911921] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"1.243001333s","start":"2026-05-11T10:45:07.646224Z","end":"2026-05-11T10:45:08.889225Z","steps":["trace[544911921] 'process raft request' (duration: 1.24212417s)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:08.888546Z","caller":"traceutil/trace.go:171","msg":"trace[652310080] transaction","detail":"{read_only:false; response_revision:2150; number_of_response:1; }","duration":"1.251879488s","start":"2026-05-11T10:45:07.636619Z","end":"2026-05-11T10:45:08.888498Z","steps":["trace[652310080] 'process raft request' (duration: 1.251471732s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:08.889456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:07.646209Z","time spent":"1.243148045s","remote":"127.0.0.1:55634","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-05-11T10:45:08.889456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:07.636567Z","time spent":"1.252795902s","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:45:09.019099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.384211ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-11T10:45:09.019653Z","caller":"traceutil/trace.go:171","msg":"trace[1039704188] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2229; }","duration":"1.347286993s","start":"2026-05-11T10:45:07.672311Z","end":"2026-05-11T10:45:09.019598Z","steps":["trace[1039704188] 'read index received' (duration: 736.598514ms)","trace[1039704188] 'applied index is now lower than readState.Index' (duration: 610.686119ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:09.020031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.347706359s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-05-11T10:45:09.020083Z","caller":"traceutil/trace.go:171","msg":"trace[1916314075] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2151; }","duration":"1.34780663s","start":"2026-05-11T10:45:07.67226Z","end":"2026-05-11T10:45:09.020067Z","steps":["trace[1916314075] 'agreement among raft nodes before linearized reading' (duration: 1.347542896s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.020161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:07.672245Z","time spent":"1.347902182s","remote":"127.0.0.1:40538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-11T10:45:09.020462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.089016899s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:45:09.020526Z","caller":"traceutil/trace.go:171","msg":"trace[1351049417] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2152; }","duration":"1.089137731s","start":"2026-05-11T10:45:07.931371Z","end":"2026-05-11T10:45:09.020509Z","steps":["trace[1351049417] 'agreement among raft nodes before linearized reading' (duration: 1.0890272s)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.020517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.011869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-11T10:45:09.020733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.790843ms","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":"warn","ts":"2026-05-11T10:45:09.020753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"658.801634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ae7cf4b88518a4\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-05-11T10:45:09.020823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"796.914733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-05-11T10:45:09.02126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.797472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-11T10:45:09.021294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.963722ms","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-05-11T10:45:09.021307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.522713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:45:09.021412Z","caller":"traceutil/trace.go:171","msg":"trace[515410489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2152; }","duration":"892.682284ms","start":"2026-05-11T10:45:08.128714Z","end":"2026-05-11T10:45:09.021396Z","steps":["trace[515410489] 'agreement among raft nodes before linearized reading' (duration: 892.515852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.021504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.128696Z","time spent":"892.794557ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-11T10:45:09.021353Z","caller":"traceutil/trace.go:171","msg":"trace[745981004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2152; }","duration":"797.463831ms","start":"2026-05-11T10:45:08.223833Z","end":"2026-05-11T10:45:09.021296Z","steps":["trace[745981004] 'agreement among raft nodes before linearized reading' (duration: 796.803991ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:09.020815Z","caller":"traceutil/trace.go:171","msg":"trace[1652377722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2152; }","duration":"775.348274ms","start":"2026-05-11T10:45:08.245423Z","end":"2026-05-11T10:45:09.020771Z","steps":["trace[1652377722] 'agreement among raft nodes before linearized reading' (duration: 774.993749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.022135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.223811Z","time spent":"798.293924ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-11T10:45:09.022199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.245407Z","time spent":"776.770876ms","remote":"127.0.0.1:55388","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-05-11T10:45:09.020796Z","caller":"traceutil/trace.go:171","msg":"trace[349464726] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2152; }","duration":"696.261235ms","start":"2026-05-11T10:45:08.32452Z","end":"2026-05-11T10:45:09.020781Z","steps":["trace[349464726] 'agreement among raft nodes before linearized reading' (duration: 696.172624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.022489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.324486Z","time spent":"697.86823ms","remote":"127.0.0.1:43086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-11T10:45:09.020604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:07.931346Z","time spent":"1.089209683s","remote":"127.0.0.1:43078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"info","ts":"2026-05-11T10:45:09.020827Z","caller":"traceutil/trace.go:171","msg":"trace[1845664858] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18ae7cf4b88518a4; range_end:; response_count:1; response_revision:2152; }","duration":"658.941716ms","start":"2026-05-11T10:45:08.361862Z","end":"2026-05-11T10:45:09.020804Z","steps":["trace[1845664858] 'agreement among raft nodes before linearized reading' (duration: 658.703232ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.022855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.361835Z","time spent":"661.000907ms","remote":"127.0.0.1:55460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":869,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18ae7cf4b88518a4\" "} {"level":"warn","ts":"2026-05-11T10:45:09.021007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.336804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12386"} {"level":"info","ts":"2026-05-11T10:45:09.02318Z","caller":"traceutil/trace.go:171","msg":"trace[893966056] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2152; }","duration":"383.693451ms","start":"2026-05-11T10:45:08.639471Z","end":"2026-05-11T10:45:09.023165Z","steps":["trace[893966056] 'agreement among raft nodes before linearized reading' (duration: 380.99024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.023519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.639442Z","time spent":"384.043467ms","remote":"127.0.0.1:55566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12409,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-05-11T10:45:09.021106Z","caller":"traceutil/trace.go:171","msg":"trace[864602882] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"244.291431ms","start":"2026-05-11T10:45:08.776796Z","end":"2026-05-11T10:45:09.021088Z","steps":["trace[864602882] 'process raft request' (duration: 242.455734ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.0212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.569619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-05-11T10:45:09.023878Z","caller":"traceutil/trace.go:171","msg":"trace[389244979] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2152; }","duration":"896.25958ms","start":"2026-05-11T10:45:08.1276Z","end":"2026-05-11T10:45:09.02386Z","steps":["trace[389244979] 'agreement among raft nodes before linearized reading' (duration: 893.499348ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.024017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.127594Z","time spent":"896.404772ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-11T10:45:09.021334Z","caller":"traceutil/trace.go:171","msg":"trace[350905791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2152; }","duration":"893.912354ms","start":"2026-05-11T10:45:08.127399Z","end":"2026-05-11T10:45:09.021311Z","steps":["trace[350905791] 'agreement among raft nodes before linearized reading' (duration: 893.758122ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.024171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.127369Z","time spent":"896.783558ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-11T10:45:09.021342Z","caller":"traceutil/trace.go:171","msg":"trace[768155698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2152; }","duration":"956.065663ms","start":"2026-05-11T10:45:08.065264Z","end":"2026-05-11T10:45:09.02133Z","steps":["trace[768155698] 'agreement among raft nodes before linearized reading' (duration: 955.893051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.024315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:08.065232Z","time spent":"959.067439ms","remote":"127.0.0.1:55634","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-05-11T10:45:09.532069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114272705670699,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-11T10:45:09.592662Z","caller":"traceutil/trace.go:171","msg":"trace[712426866] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"564.347929ms","start":"2026-05-11T10:45:09.028279Z","end":"2026-05-11T10:45:09.592627Z","steps":["trace[712426866] 'process raft request' (duration: 562.984879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.592939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.02826Z","time spent":"564.486621ms","remote":"127.0.0.1:55460","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:09.596892Z","caller":"traceutil/trace.go:171","msg":"trace[1655390505] transaction","detail":"{read_only:false; response_revision:2155; number_of_response:1; }","duration":"567.482428ms","start":"2026-05-11T10:45:09.029359Z","end":"2026-05-11T10:45:09.596841Z","steps":["trace[1655390505] 'process raft request' (duration: 567.352386ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:09.597143Z","caller":"traceutil/trace.go:171","msg":"trace[932897711] transaction","detail":"{read_only:false; response_revision:2156; number_of_response:1; }","duration":"567.399387ms","start":"2026-05-11T10:45:09.029715Z","end":"2026-05-11T10:45:09.597114Z","steps":["trace[932897711] 'process raft request' (duration: 567.076502ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.59718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.029354Z","time spent":"567.62954ms","remote":"127.0.0.1:55634","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-05-11T10:45:09.597318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.029704Z","time spent":"567.523639ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:09.597339Z","caller":"traceutil/trace.go:171","msg":"trace[340789523] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"567.907414ms","start":"2026-05-11T10:45:09.029283Z","end":"2026-05-11T10:45:09.597191Z","steps":["trace[340789523] 'process raft request' (duration: 567.242324ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.597711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.029262Z","time spent":"568.263429ms","remote":"127.0.0.1:55634","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-05-11T10:45:09.59787Z","caller":"traceutil/trace.go:171","msg":"trace[481860900] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"567.991166ms","start":"2026-05-11T10:45:09.029856Z","end":"2026-05-11T10:45:09.597848Z","steps":["trace[481860900] 'process raft request' (duration: 567.166214ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:09.59814Z","caller":"traceutil/trace.go:171","msg":"trace[26112044] transaction","detail":"{read_only:false; response_revision:2158; number_of_response:1; }","duration":"568.230329ms","start":"2026-05-11T10:45:09.029894Z","end":"2026-05-11T10:45:09.598124Z","steps":["trace[26112044] 'process raft request' (duration: 567.844563ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:09.598183Z","caller":"traceutil/trace.go:171","msg":"trace[1335202393] linearizableReadLoop","detail":"{readStateIndex:2242; appliedIndex:2235; }","duration":"566.36666ms","start":"2026-05-11T10:45:09.031725Z","end":"2026-05-11T10:45:09.598092Z","steps":["trace[1335202393] 'read index received' (duration: 559.558137ms)","trace[1335202393] 'applied index is now lower than readState.Index' (duration: 6.806723ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:09.598221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.02989Z","time spent":"568.29068ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:45:09.598403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.674155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:45:09.598441Z","caller":"traceutil/trace.go:171","msg":"trace[1703814683] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2159; }","duration":"566.732935ms","start":"2026-05-11T10:45:09.031698Z","end":"2026-05-11T10:45:09.598431Z","steps":["trace[1703814683] 'agreement among raft nodes before linearized reading' (duration: 566.643294ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.598196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.029849Z","time spent":"568.178628ms","remote":"127.0.0.1:55634","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-05-11T10:45:09.598478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.031692Z","time spent":"566.776927ms","remote":"127.0.0.1:55826","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"info","ts":"2026-05-11T10:45:09.598287Z","caller":"traceutil/trace.go:171","msg":"trace[1157023655] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"556.727813ms","start":"2026-05-11T10:45:09.041543Z","end":"2026-05-11T10:45:09.59827Z","steps":["trace[1157023655] 'process raft request' (duration: 556.473539ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:09.598706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:09.041535Z","time spent":"556.978907ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:15.804263Z","caller":"traceutil/trace.go:171","msg":"trace[914017845] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"180.01933ms","start":"2026-05-11T10:45:15.624198Z","end":"2026-05-11T10:45:15.804217Z","steps":["trace[914017845] 'process raft request' (duration: 179.884128ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:15.807817Z","caller":"traceutil/trace.go:171","msg":"trace[1172058620] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"181.551711ms","start":"2026-05-11T10:45:15.626237Z","end":"2026-05-11T10:45:15.807788Z","steps":["trace[1172058620] 'process raft request' (duration: 181.385049ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:15.808311Z","caller":"traceutil/trace.go:171","msg":"trace[1807056567] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"181.975788ms","start":"2026-05-11T10:45:15.626305Z","end":"2026-05-11T10:45:15.80828Z","steps":["trace[1807056567] 'process raft request' (duration: 181.43534ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:15.808513Z","caller":"traceutil/trace.go:171","msg":"trace[813555384] linearizableReadLoop","detail":"{readStateIndex:2274; appliedIndex:2270; }","duration":"178.971143ms","start":"2026-05-11T10:45:15.629526Z","end":"2026-05-11T10:45:15.808497Z","steps":["trace[813555384] 'read index received' (duration: 174.587698ms)","trace[813555384] 'applied index is now lower than readState.Index' (duration: 4.382505ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:15.808665Z","caller":"traceutil/trace.go:171","msg":"trace[2092972070] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"182.278272ms","start":"2026-05-11T10:45:15.626375Z","end":"2026-05-11T10:45:15.808653Z","steps":["trace[2092972070] 'process raft request' (duration: 182.040419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:15.808677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.126085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:45:15.808711Z","caller":"traceutil/trace.go:171","msg":"trace[1117531356] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2190; }","duration":"179.203717ms","start":"2026-05-11T10:45:15.629497Z","end":"2026-05-11T10:45:15.808701Z","steps":["trace[1117531356] 'agreement among raft nodes before linearized reading' (duration: 179.062055ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:19.941685Z","caller":"traceutil/trace.go:171","msg":"trace[2089472061] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"114.444499ms","start":"2026-05-11T10:45:19.82721Z","end":"2026-05-11T10:45:19.941655Z","steps":["trace[2089472061] 'read index received' (duration: 40.761454ms)","trace[2089472061] 'applied index is now lower than readState.Index' (duration: 73.681655ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:19.941824Z","caller":"traceutil/trace.go:171","msg":"trace[2096362999] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"111.468066ms","start":"2026-05-11T10:45:19.830326Z","end":"2026-05-11T10:45:19.941794Z","steps":["trace[2096362999] 'process raft request' (duration: 111.298014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:19.942137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.348695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-05-11T10:45:19.942134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.215909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-11T10:45:19.942182Z","caller":"traceutil/trace.go:171","msg":"trace[1058590041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2211; }","duration":"120.482277ms","start":"2026-05-11T10:45:19.821688Z","end":"2026-05-11T10:45:19.942171Z","steps":["trace[1058590041] 'agreement among raft nodes before linearized reading' (duration: 120.083242ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:19.942198Z","caller":"traceutil/trace.go:171","msg":"trace[1480563041] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2211; }","duration":"119.335021ms","start":"2026-05-11T10:45:19.822846Z","end":"2026-05-11T10:45:19.942181Z","steps":["trace[1480563041] 'agreement among raft nodes before linearized reading' (duration: 119.136138ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:19.942397Z","caller":"traceutil/trace.go:171","msg":"trace[1116197199] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"116.826164ms","start":"2026-05-11T10:45:19.824906Z","end":"2026-05-11T10:45:19.941732Z","steps":["trace[1116197199] 'process raft request' (duration: 42.968736ms)","trace[1116197199] 'compare' (duration: 73.561124ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:47.253269Z","caller":"traceutil/trace.go:171","msg":"trace[171953835] transaction","detail":"{read_only:false; response_revision:2412; number_of_response:1; }","duration":"122.018193ms","start":"2026-05-11T10:45:47.13121Z","end":"2026-05-11T10:45:47.253228Z","steps":["trace[171953835] 'process raft request' (duration: 121.691719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:49.229973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.911019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:45:49.230218Z","caller":"traceutil/trace.go:171","msg":"trace[50198121] transaction","detail":"{read_only:false; response_revision:2427; number_of_response:1; }","duration":"138.543573ms","start":"2026-05-11T10:45:49.091654Z","end":"2026-05-11T10:45:49.230198Z","steps":["trace[50198121] 'process raft request' (duration: 138.478392ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:45:49.230548Z","caller":"traceutil/trace.go:171","msg":"trace[685406610] transaction","detail":"{read_only:false; response_revision:2426; number_of_response:1; }","duration":"199.538008ms","start":"2026-05-11T10:45:49.030999Z","end":"2026-05-11T10:45:49.230537Z","steps":["trace[685406610] 'process raft request' (duration: 74.93873ms)","trace[685406610] 'compare' (duration: 123.738387ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:45:56.139931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114272705671500,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-11T10:45:56.331723Z","caller":"traceutil/trace.go:171","msg":"trace[1873569142] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"740.600532ms","start":"2026-05-11T10:45:55.591091Z","end":"2026-05-11T10:45:56.331691Z","steps":["trace[1873569142] 'process raft request' (duration: 740.43405ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:56.332018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:55.591073Z","time spent":"740.731304ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:45:56.351641Z","caller":"traceutil/trace.go:171","msg":"trace[1296419932] linearizableReadLoop","detail":"{readStateIndex:2605; appliedIndex:2603; }","duration":"712.197361ms","start":"2026-05-11T10:45:55.639416Z","end":"2026-05-11T10:45:56.351614Z","steps":["trace[1296419932] 'read index received' (duration: 692.11778ms)","trace[1296419932] 'applied index is now lower than readState.Index' (duration: 20.078491ms)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:45:56.351727Z","caller":"traceutil/trace.go:171","msg":"trace[884067857] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"637.000192ms","start":"2026-05-11T10:45:55.714687Z","end":"2026-05-11T10:45:56.351687Z","steps":["trace[884067857] 'process raft request' (duration: 636.11758ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:56.351846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:55.714673Z","time spent":"637.130264ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:45:56.351926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.488735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-11T10:45:56.352002Z","caller":"traceutil/trace.go:171","msg":"trace[2137897065] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2511; }","duration":"712.636996ms","start":"2026-05-11T10:45:55.639354Z","end":"2026-05-11T10:45:56.351991Z","steps":["trace[2137897065] 'agreement among raft nodes before linearized reading' (duration: 712.428474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:56.351989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.100165ms","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-05-11T10:45:56.352045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:55.639331Z","time spent":"712.705227ms","remote":"127.0.0.1:55578","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":1392,"request content":"key:\"/registry/services/specs/auth-system/keycloak-headless\" "} {"level":"info","ts":"2026-05-11T10:45:56.352059Z","caller":"traceutil/trace.go:171","msg":"trace[1346610775] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2511; }","duration":"356.227696ms","start":"2026-05-11T10:45:55.995815Z","end":"2026-05-11T10:45:56.352042Z","steps":["trace[1346610775] 'agreement among raft nodes before linearized reading' (duration: 356.029334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:56.352086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:45:55.995795Z","time spent":"356.286128ms","remote":"127.0.0.1:55634","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-05-11T10:45:56.352185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.370181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-11T10:45:56.352205Z","caller":"traceutil/trace.go:171","msg":"trace[343054837] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2511; }","duration":"196.387881ms","start":"2026-05-11T10:45:56.155811Z","end":"2026-05-11T10:45:56.352199Z","steps":["trace[343054837] 'agreement among raft nodes before linearized reading' (duration: 196.34467ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:56.35227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.532753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-11T10:45:56.352286Z","caller":"traceutil/trace.go:171","msg":"trace[2021437250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2511; }","duration":"196.590923ms","start":"2026-05-11T10:45:56.155692Z","end":"2026-05-11T10:45:56.352283Z","steps":["trace[2021437250] 'agreement among raft nodes before linearized reading' (duration: 196.547853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:56.352344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.66438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-11T10:45:56.352358Z","caller":"traceutil/trace.go:171","msg":"trace[1854860862] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2511; }","duration":"238.72626ms","start":"2026-05-11T10:45:56.113629Z","end":"2026-05-11T10:45:56.352355Z","steps":["trace[1854860862] 'agreement among raft nodes before linearized reading' (duration: 238.68819ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:45:56.352435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.632276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-11T10:45:56.352517Z","caller":"traceutil/trace.go:171","msg":"trace[28416307] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2511; }","duration":"210.747387ms","start":"2026-05-11T10:45:56.141738Z","end":"2026-05-11T10:45:56.352485Z","steps":["trace[28416307] 'agreement among raft nodes before linearized reading' (duration: 210.514174ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:46:23.348621Z","caller":"traceutil/trace.go:171","msg":"trace[1467683711] linearizableReadLoop","detail":"{readStateIndex:2763; appliedIndex:2762; }","duration":"118.448005ms","start":"2026-05-11T10:46:23.230152Z","end":"2026-05-11T10:46:23.3486Z","steps":["trace[1467683711] 'read index received' (duration: 118.261283ms)","trace[1467683711] 'applied index is now lower than readState.Index' (duration: 186.042µs)"],"step_count":2} {"level":"info","ts":"2026-05-11T10:46:23.348902Z","caller":"traceutil/trace.go:171","msg":"trace[1738067525] transaction","detail":"{read_only:false; response_revision:2663; number_of_response:1; }","duration":"172.978346ms","start":"2026-05-11T10:46:23.175914Z","end":"2026-05-11T10:46:23.348892Z","steps":["trace[1738067525] 'process raft request' (duration: 172.550191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:46:23.349231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.063433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-05-11T10:46:23.349258Z","caller":"traceutil/trace.go:171","msg":"trace[1315081745] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2663; }","duration":"119.152953ms","start":"2026-05-11T10:46:23.230097Z","end":"2026-05-11T10:46:23.34925Z","steps":["trace[1315081745] 'agreement among raft nodes before linearized reading' (duration: 119.030252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:46:23.349377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.772149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-11T10:46:23.349396Z","caller":"traceutil/trace.go:171","msg":"trace[1680158518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2663; }","duration":"105.81125ms","start":"2026-05-11T10:46:23.243579Z","end":"2026-05-11T10:46:23.34939Z","steps":["trace[1680158518] 'agreement among raft nodes before linearized reading' (duration: 105.782249ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:46:28.810885Z","caller":"traceutil/trace.go:171","msg":"trace[357364717] transaction","detail":"{read_only:false; response_revision:2694; number_of_response:1; }","duration":"113.792417ms","start":"2026-05-11T10:46:28.697071Z","end":"2026-05-11T10:46:28.810863Z","steps":["trace[357364717] 'process raft request' (duration: 113.655615ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:46:29.52032Z","caller":"traceutil/trace.go:171","msg":"trace[1009399605] transaction","detail":"{read_only:false; response_revision:2696; number_of_response:1; }","duration":"145.550741ms","start":"2026-05-11T10:46:29.374743Z","end":"2026-05-11T10:46:29.520294Z","steps":["trace[1009399605] 'process raft request' (duration: 145.397469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:46:29.829551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.488679ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-11T10:46:29.829928Z","caller":"traceutil/trace.go:171","msg":"trace[185074008] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"412.316918ms","start":"2026-05-11T10:46:29.417529Z","end":"2026-05-11T10:46:29.829846Z","steps":["trace[185074008] 'process raft request' (duration: 412.136495ms)"],"step_count":1} {"level":"info","ts":"2026-05-11T10:46:29.829955Z","caller":"traceutil/trace.go:171","msg":"trace[1972738796] transaction","detail":"{read_only:false; response_revision:2697; number_of_response:1; }","duration":"419.264542ms","start":"2026-05-11T10:46:29.410658Z","end":"2026-05-11T10:46:29.829923Z","steps":["trace[1972738796] 'process raft request' (duration: 172.296787ms)","trace[1972738796] 'compare' (duration: 246.279625ms)"],"step_count":2} {"level":"warn","ts":"2026-05-11T10:46:29.830182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:46:29.410641Z","time spent":"419.383973ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-11T10:46:29.830263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.302537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-11T10:46:29.830341Z","caller":"traceutil/trace.go:171","msg":"trace[2017255717] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2698; }","duration":"191.430159ms","start":"2026-05-11T10:46:29.638896Z","end":"2026-05-11T10:46:29.830326Z","steps":["trace[2017255717] 'agreement among raft nodes before linearized reading' (duration: 191.201817ms)"],"step_count":1} {"level":"warn","ts":"2026-05-11T10:46:29.830466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-11T10:46:29.41749Z","time spent":"412.509749ms","remote":"127.0.0.1:55634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-11T10:46:29.831629Z","caller":"traceutil/trace.go:171","msg":"trace[749847583] linearizableReadLoop","detail":"{readStateIndex:2800; appliedIndex:2798; }","duration":"192.661944ms","start":"2026-05-11T10:46:29.638946Z","end":"2026-05-11T10:46:29.831607Z","steps":["trace[749847583] 'read index received' (duration: 20.74µs)","trace[749847583] 'applied index is now lower than readState.Index' (duration: 190.785631ms)"],"step_count":2}