{"level":"warn","ts":"2026-04-07T09:42:51.524307Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T09:42:51.52444Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.162: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.162:2380","--initial-cluster=instance=https://199.204.45.162:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.162:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.162:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T09:42:51.524537Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T09:42:51.524554Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-04-07T09:42:51.524574Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T09:42:51.525267Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"]} {"level":"info","ts":"2026-04-07T09:42:51.525349Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.162:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T09:42:51.529843Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.260584ms"} {"level":"info","ts":"2026-04-07T09:42:51.542457Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2d372260bb4c37a","cluster-id":"52bb6ec15e8722ff"} {"level":"info","ts":"2026-04-07T09:42:51.542708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T09:42:51.542796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 0"} {"level":"info","ts":"2026-04-07T09:42:51.542831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2d372260bb4c37a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T09:42:51.542844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became follower at term 1"} {"level":"info","ts":"2026-04-07T09:42:51.542917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"warn","ts":"2026-04-07T09:42:51.551464Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T09:42:51.553049Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T09:42:51.554633Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-07T09:42:51.559493Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2d372260bb4c37a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T09:42:51.559738Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2d372260bb4c37a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T09:42:51.560129Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T09:42:51.560378Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T09:42:51.560531Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T09:42:51.561203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a switched to configuration voters=(203631915892523898)"} {"level":"info","ts":"2026-04-07T09:42:51.562364Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","added-peer-id":"2d372260bb4c37a","added-peer-peer-urls":["https://199.204.45.162:2380"]} {"level":"info","ts":"2026-04-07T09:42:51.565565Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T09:42:51.565699Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-04-07T09:42:51.565731Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.162:2380"} {"level":"info","ts":"2026-04-07T09:42:51.56678Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2d372260bb4c37a","initial-advertise-peer-urls":["https://199.204.45.162:2380"],"listen-peer-urls":["https://199.204.45.162:2380"],"advertise-client-urls":["https://199.204.45.162:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.162:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T09:42:51.566845Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T09:42:51.747586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T09:42:51.747791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T09:42:51.747848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgPreVoteResp from 2d372260bb4c37a at term 1"} {"level":"info","ts":"2026-04-07T09:42:51.747865Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became candidate at term 2"} {"level":"info","ts":"2026-04-07T09:42:51.747871Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a received MsgVoteResp from 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-04-07T09:42:51.74788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2d372260bb4c37a became leader at term 2"} {"level":"info","ts":"2026-04-07T09:42:51.747888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2d372260bb4c37a elected leader 2d372260bb4c37a at term 2"} {"level":"info","ts":"2026-04-07T09:42:51.750158Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:51.753747Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:42:51.753775Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2d372260bb4c37a","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.162:2379]}","request-path":"/0/members/2d372260bb4c37a/attributes","cluster-id":"52bb6ec15e8722ff","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T09:42:51.753856Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:42:51.754311Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"52bb6ec15e8722ff","local-member-id":"2d372260bb4c37a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:51.754309Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T09:42:51.754405Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T09:42:51.754437Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:51.754576Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:42:51.757644Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.162:2379"} {"level":"info","ts":"2026-04-07T09:42:51.757919Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-07T09:43:16.71337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"620.802421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:43:16.713526Z","caller":"traceutil/trace.go:171","msg":"trace[267497811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:464; }","duration":"621.022067ms","start":"2026-04-07T09:43:16.09248Z","end":"2026-04-07T09:43:16.713502Z","steps":["trace[267497811] 'range keys from in-memory index tree' (duration: 620.699639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:16.713549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.142597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-07T09:43:16.713584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:16.092455Z","time spent":"621.116349ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T09:43:16.713674Z","caller":"traceutil/trace.go:171","msg":"trace[952832371] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:464; }","duration":"561.346212ms","start":"2026-04-07T09:43:16.152301Z","end":"2026-04-07T09:43:16.713647Z","steps":["trace[952832371] 'range keys from in-memory index tree' (duration: 561.000334ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:16.71373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:16.152274Z","time spent":"561.445634ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T09:43:16.850996Z","caller":"traceutil/trace.go:171","msg":"trace[2076057937] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"132.617911ms","start":"2026-04-07T09:43:16.71835Z","end":"2026-04-07T09:43:16.850967Z","steps":["trace[2076057937] 'process raft request' (duration: 97.266615ms)","trace[2076057937] 'compare' (duration: 35.176102ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:16.851178Z","caller":"traceutil/trace.go:171","msg":"trace[17113493] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"132.455728ms","start":"2026-04-07T09:43:16.71869Z","end":"2026-04-07T09:43:16.851146Z","steps":["trace[17113493] 'process raft request' (duration: 132.236842ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:21.826638Z","caller":"traceutil/trace.go:171","msg":"trace[303144121] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"108.836225ms","start":"2026-04-07T09:43:21.717776Z","end":"2026-04-07T09:43:21.826612Z","steps":["trace[303144121] 'process raft request' (duration: 104.08108ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.743573Z","caller":"traceutil/trace.go:171","msg":"trace[687405448] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"175.789897ms","start":"2026-04-07T09:43:23.567755Z","end":"2026-04-07T09:43:23.743545Z","steps":["trace[687405448] 'process raft request' (duration: 175.662724ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.747885Z","caller":"traceutil/trace.go:171","msg":"trace[1124203770] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"103.142337ms","start":"2026-04-07T09:43:23.644715Z","end":"2026-04-07T09:43:23.747857Z","steps":["trace[1124203770] 'process raft request' (duration: 103.089566ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748014Z","caller":"traceutil/trace.go:171","msg":"trace[733547571] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"180.155192ms","start":"2026-04-07T09:43:23.567834Z","end":"2026-04-07T09:43:23.747989Z","steps":["trace[733547571] 'process raft request' (duration: 179.451975ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748022Z","caller":"traceutil/trace.go:171","msg":"trace[1465101701] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"167.341692ms","start":"2026-04-07T09:43:23.580635Z","end":"2026-04-07T09:43:23.747976Z","steps":["trace[1465101701] 'process raft request' (duration: 166.86064ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748169Z","caller":"traceutil/trace.go:171","msg":"trace[520419050] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"165.543118ms","start":"2026-04-07T09:43:23.582616Z","end":"2026-04-07T09:43:23.748159Z","steps":["trace[520419050] 'process raft request' (duration: 164.918953ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748274Z","caller":"traceutil/trace.go:171","msg":"trace[977850853] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"164.697068ms","start":"2026-04-07T09:43:23.583569Z","end":"2026-04-07T09:43:23.748266Z","steps":["trace[977850853] 'process raft request' (duration: 164.004281ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748325Z","caller":"traceutil/trace.go:171","msg":"trace[387641413] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"176.409931ms","start":"2026-04-07T09:43:23.571902Z","end":"2026-04-07T09:43:23.748312Z","steps":["trace[387641413] 'process raft request' (duration: 175.509069ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748352Z","caller":"traceutil/trace.go:171","msg":"trace[363903906] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"163.798256ms","start":"2026-04-07T09:43:23.584543Z","end":"2026-04-07T09:43:23.748342Z","steps":["trace[363903906] 'process raft request' (duration: 163.075928ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748428Z","caller":"traceutil/trace.go:171","msg":"trace[431207539] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"159.247466ms","start":"2026-04-07T09:43:23.589172Z","end":"2026-04-07T09:43:23.74842Z","steps":["trace[431207539] 'process raft request' (duration: 158.499588ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748521Z","caller":"traceutil/trace.go:171","msg":"trace[778265256] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"139.945708ms","start":"2026-04-07T09:43:23.608567Z","end":"2026-04-07T09:43:23.748512Z","steps":["trace[778265256] 'process raft request' (duration: 139.162139ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:23.748523Z","caller":"traceutil/trace.go:171","msg":"trace[1589757295] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"168.014878ms","start":"2026-04-07T09:43:23.580494Z","end":"2026-04-07T09:43:23.748509Z","steps":["trace[1589757295] 'process raft request' (duration: 166.957232ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:27.128571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.036337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T09:43:27.128662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.906589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T09:43:27.128643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.603506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T09:43:27.128739Z","caller":"traceutil/trace.go:171","msg":"trace[916202730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:600; }","duration":"214.001181ms","start":"2026-04-07T09:43:26.91472Z","end":"2026-04-07T09:43:27.128722Z","steps":["trace[916202730] 'range keys from in-memory index tree' (duration: 213.809706ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:27.128789Z","caller":"traceutil/trace.go:171","msg":"trace[2111043103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"221.79077ms","start":"2026-04-07T09:43:26.906967Z","end":"2026-04-07T09:43:27.128758Z","steps":["trace[2111043103] 'range keys from in-memory index tree' (duration: 221.428151ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:27.12871Z","caller":"traceutil/trace.go:171","msg":"trace[2001538496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:600; }","duration":"246.195131ms","start":"2026-04-07T09:43:26.882494Z","end":"2026-04-07T09:43:27.128689Z","steps":["trace[2001538496] 'range keys from in-memory index tree' (duration: 245.911794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:27.128553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.795686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:27.128969Z","caller":"traceutil/trace.go:171","msg":"trace[1357815518] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:600; }","duration":"259.260748ms","start":"2026-04-07T09:43:26.869685Z","end":"2026-04-07T09:43:27.128946Z","steps":["trace[1357815518] 'range keys from in-memory index tree' (duration: 258.708224ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:30.558172Z","caller":"traceutil/trace.go:171","msg":"trace[405807176] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"459.077155ms","start":"2026-04-07T09:43:30.099053Z","end":"2026-04-07T09:43:30.55813Z","steps":["trace[405807176] 'process raft request' (duration: 458.121872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:30.560243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.09902Z","time spent":"459.25257ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:43:31.486991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.440064ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-07T09:43:31.487292Z","caller":"traceutil/trace.go:171","msg":"trace[1854242658] linearizableReadLoop","detail":"{readStateIndex:650; appliedIndex:648; }","duration":"840.994762ms","start":"2026-04-07T09:43:30.646269Z","end":"2026-04-07T09:43:31.487264Z","steps":["trace[1854242658] 'read index received' (duration: 78.362µs)","trace[1854242658] 'applied index is now lower than readState.Index' (duration: 840.91497ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.487405Z","caller":"traceutil/trace.go:171","msg":"trace[1206104556] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"864.712448ms","start":"2026-04-07T09:43:30.622684Z","end":"2026-04-07T09:43:31.487396Z","steps":["trace[1206104556] 'process raft request' (duration: 864.3859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:31.487487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.622649Z","time spent":"864.780228ms","remote":"127.0.0.1:37880","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:43:31.533036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.665758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.533122Z","caller":"traceutil/trace.go:171","msg":"trace[1129916533] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"582.781171ms","start":"2026-04-07T09:43:30.950323Z","end":"2026-04-07T09:43:31.533104Z","steps":["trace[1129916533] 'agreement among raft nodes before linearized reading' (duration: 537.620967ms)","trace[1129916533] 'range keys from in-memory index tree' (duration: 44.995849ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.533165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.950262Z","time spent":"582.894274ms","remote":"127.0.0.1:54992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.533238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.031691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.533352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"738.923382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.533394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.836535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.53337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.856046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.533425Z","caller":"traceutil/trace.go:171","msg":"trace[1495830357] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"127.899337ms","start":"2026-04-07T09:43:31.405515Z","end":"2026-04-07T09:43:31.533415Z","steps":["trace[1495830357] 'agreement among raft nodes before linearized reading' (duration: 82.314273ms)","trace[1495830357] 'count revisions from in-memory index tree' (duration: 45.544913ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.533463Z","caller":"traceutil/trace.go:171","msg":"trace[1594260009] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"680.990889ms","start":"2026-04-07T09:43:30.852448Z","end":"2026-04-07T09:43:31.533439Z","steps":["trace[1594260009] 'agreement among raft nodes before linearized reading' (duration: 635.583469ms)","trace[1594260009] 'count revisions from in-memory index tree' (duration: 45.278247ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.53345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.827861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.533512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.852437Z","time spent":"681.06229ms","remote":"127.0.0.1:54954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:43:31.533564Z","caller":"traceutil/trace.go:171","msg":"trace[1185518766] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"126.998065ms","start":"2026-04-07T09:43:31.406528Z","end":"2026-04-07T09:43:31.533526Z","steps":["trace[1185518766] 'agreement among raft nodes before linearized reading' (duration: 81.232756ms)","trace[1185518766] 'range keys from in-memory index tree' (duration: 45.509312ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.533632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.078093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.533621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.325624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.533601Z","caller":"traceutil/trace.go:171","msg":"trace[1395377798] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"739.064315ms","start":"2026-04-07T09:43:30.794361Z","end":"2026-04-07T09:43:31.533426Z","steps":["trace[1395377798] 'agreement among raft nodes before linearized reading' (duration: 693.614725ms)","trace[1395377798] 'count revisions from in-memory index tree' (duration: 45.337818ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.533692Z","caller":"traceutil/trace.go:171","msg":"trace[1544166603] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"653.128624ms","start":"2026-04-07T09:43:30.880541Z","end":"2026-04-07T09:43:31.533669Z","steps":["trace[1544166603] 'agreement among raft nodes before linearized reading' (duration: 607.445188ms)","trace[1544166603] 'range keys from in-memory index tree' (duration: 45.619805ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.5337Z","caller":"traceutil/trace.go:171","msg":"trace[577113185] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"887.451887ms","start":"2026-04-07T09:43:30.646228Z","end":"2026-04-07T09:43:31.53368Z","steps":["trace[577113185] 'agreement among raft nodes before linearized reading' (duration: 841.399042ms)","trace[577113185] 'count revisions from in-memory index tree' (duration: 45.944753ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.53373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.88047Z","time spent":"653.251027ms","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.533723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.794337Z","time spent":"739.373342ms","remote":"127.0.0.1:54932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.533742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.646207Z","time spent":"887.52317ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.533792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.569874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.533803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.601225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T09:43:31.533827Z","caller":"traceutil/trace.go:171","msg":"trace[876806457] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"330.668187ms","start":"2026-04-07T09:43:31.203148Z","end":"2026-04-07T09:43:31.533817Z","steps":["trace[876806457] 'agreement among raft nodes before linearized reading' (duration: 284.777245ms)","trace[876806457] 'range keys from in-memory index tree' (duration: 45.84999ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.533832Z","caller":"traceutil/trace.go:171","msg":"trace[121709745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:625; }","duration":"368.668537ms","start":"2026-04-07T09:43:31.165155Z","end":"2026-04-07T09:43:31.533824Z","steps":["trace[121709745] 'agreement among raft nodes before linearized reading' (duration: 322.871158ms)","trace[121709745] 'range keys from in-memory index tree' (duration: 45.661796ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.533857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.16512Z","time spent":"368.730749ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T09:43:31.533883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.286482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.533905Z","caller":"traceutil/trace.go:171","msg":"trace[445072490] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:625; }","duration":"146.319393ms","start":"2026-04-07T09:43:31.387578Z","end":"2026-04-07T09:43:31.533897Z","steps":["trace[445072490] 'agreement among raft nodes before linearized reading' (duration: 100.308819ms)","trace[445072490] 'count revisions from in-memory index tree' (duration: 45.983093ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.533908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"887.443738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.533943Z","caller":"traceutil/trace.go:171","msg":"trace[1719503929] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"887.52367ms","start":"2026-04-07T09:43:30.646409Z","end":"2026-04-07T09:43:31.533933Z","steps":["trace[1719503929] 'agreement among raft nodes before linearized reading' (duration: 841.253689ms)","trace[1719503929] 'range keys from in-memory index tree' (duration: 46.22668ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.533972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.978842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.533986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.232427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.534023Z","caller":"traceutil/trace.go:171","msg":"trace[1591582103] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:625; }","duration":"532.303338ms","start":"2026-04-07T09:43:31.001708Z","end":"2026-04-07T09:43:31.534011Z","steps":["trace[1591582103] 'agreement among raft nodes before linearized reading' (duration: 486.330995ms)","trace[1591582103] 'range keys from in-memory index tree' (duration: 45.931193ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.53404Z","caller":"traceutil/trace.go:171","msg":"trace[830837699] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:625; }","duration":"708.147876ms","start":"2026-04-07T09:43:30.825844Z","end":"2026-04-07T09:43:31.533992Z","steps":["trace[830837699] 'agreement among raft nodes before linearized reading' (duration: 662.163432ms)","trace[830837699] 'range keys from in-memory index tree' (duration: 45.937392ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.001679Z","time spent":"532.36351ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.534039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.574571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.534057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.518167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.53407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.825811Z","time spent":"708.251029ms","remote":"127.0.0.1:54946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.53409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.065527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.534094Z","caller":"traceutil/trace.go:171","msg":"trace[1014813668] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"331.583679ms","start":"2026-04-07T09:43:31.202499Z","end":"2026-04-07T09:43:31.534083Z","steps":["trace[1014813668] 'agreement among raft nodes before linearized reading' (duration: 285.435472ms)","trace[1014813668] 'range keys from in-memory index tree' (duration: 46.097516ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.534145Z","caller":"traceutil/trace.go:171","msg":"trace[776055661] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:625; }","duration":"177.101408ms","start":"2026-04-07T09:43:31.357008Z","end":"2026-04-07T09:43:31.53411Z","steps":["trace[776055661] 'agreement among raft nodes before linearized reading' (duration: 130.892209ms)","trace[776055661] 'range keys from in-memory index tree' (duration: 46.174598ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.534092Z","caller":"traceutil/trace.go:171","msg":"trace[2099035097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:625; }","duration":"448.703034ms","start":"2026-04-07T09:43:31.085374Z","end":"2026-04-07T09:43:31.534077Z","steps":["trace[2099035097] 'agreement among raft nodes before linearized reading' (duration: 402.588077ms)","trace[2099035097] 'range keys from in-memory index tree' (duration: 46.029995ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.472794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.534233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.54225ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.534234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.230679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.534252Z","caller":"traceutil/trace.go:171","msg":"trace[2067713713] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"613.586457ms","start":"2026-04-07T09:43:30.920654Z","end":"2026-04-07T09:43:31.534241Z","steps":["trace[2067713713] 'agreement among raft nodes before linearized reading' (duration: 567.291326ms)","trace[2067713713] 'count revisions from in-memory index tree' (duration: 46.216529ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.095542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.534444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.469787ms","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":"warn","ts":"2026-04-07T09:43:31.534469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.961584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.534471Z","caller":"traceutil/trace.go:171","msg":"trace[1604526316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"681.283426ms","start":"2026-04-07T09:43:30.853176Z","end":"2026-04-07T09:43:31.53446Z","steps":["trace[1604526316] 'agreement among raft nodes before linearized reading' (duration: 634.835072ms)","trace[1604526316] 'range keys from in-memory index tree' (duration: 46.237579ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.534487Z","caller":"traceutil/trace.go:171","msg":"trace[1425540894] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:625; }","duration":"438.540559ms","start":"2026-04-07T09:43:31.095933Z","end":"2026-04-07T09:43:31.534474Z","steps":["trace[1425540894] 'agreement among raft nodes before linearized reading' (duration: 392.182456ms)","trace[1425540894] 'range keys from in-memory index tree' (duration: 46.287731ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.534501Z","caller":"traceutil/trace.go:171","msg":"trace[412334207] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"654.046516ms","start":"2026-04-07T09:43:30.880445Z","end":"2026-04-07T09:43:31.534492Z","steps":["trace[412334207] 'agreement among raft nodes before linearized reading' (duration: 607.55236ms)","trace[412334207] 'count revisions from in-memory index tree' (duration: 46.454625ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.533986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.64638Z","time spent":"887.597842ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.534527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.880419Z","time spent":"654.101318ms","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.534536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.853115Z","time spent":"681.396929ms","remote":"127.0.0.1:54954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:43:31.533856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.203113Z","time spent":"330.734629ms","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 "} {"level":"info","ts":"2026-04-07T09:43:31.533353Z","caller":"traceutil/trace.go:171","msg":"trace[602185533] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:625; }","duration":"145.186435ms","start":"2026-04-07T09:43:31.388138Z","end":"2026-04-07T09:43:31.533325Z","steps":["trace[602185533] 'agreement among raft nodes before linearized reading' (duration: 99.739484ms)","trace[602185533] 'range keys from in-memory index tree' (duration: 45.277577ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.53348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.89597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.534668Z","caller":"traceutil/trace.go:171","msg":"trace[1646342791] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:625; }","duration":"493.140831ms","start":"2026-04-07T09:43:31.041516Z","end":"2026-04-07T09:43:31.534657Z","steps":["trace[1646342791] 'agreement among raft nodes before linearized reading' (duration: 446.488211ms)","trace[1646342791] 'count revisions from in-memory index tree' (duration: 45.334117ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.095914Z","time spent":"438.60154ms","remote":"127.0.0.1:55026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.5347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.041457Z","time spent":"493.235363ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.534734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.397903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.534187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.085352Z","time spent":"448.823517ms","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:43:31.53406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.498557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.534781Z","caller":"traceutil/trace.go:171","msg":"trace[2042440376] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"739.486085ms","start":"2026-04-07T09:43:30.795283Z","end":"2026-04-07T09:43:31.534769Z","steps":["trace[2042440376] 'agreement among raft nodes before linearized reading' (duration: 692.736573ms)","trace[2042440376] 'range keys from in-memory index tree' (duration: 46.692611ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.337747ms","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":"warn","ts":"2026-04-07T09:43:31.534846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.115745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.534873Z","caller":"traceutil/trace.go:171","msg":"trace[2070393373] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:625; }","duration":"682.183278ms","start":"2026-04-07T09:43:30.852682Z","end":"2026-04-07T09:43:31.534865Z","steps":["trace[2070393373] 'agreement among raft nodes before linearized reading' (duration: 635.340104ms)","trace[2070393373] 'range keys from in-memory index tree' (duration: 46.807883ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.852656Z","time spent":"682.242789ms","remote":"127.0.0.1:54954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"info","ts":"2026-04-07T09:43:31.534867Z","caller":"traceutil/trace.go:171","msg":"trace[526367093] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:625; }","duration":"332.44949ms","start":"2026-04-07T09:43:31.202407Z","end":"2026-04-07T09:43:31.534857Z","steps":["trace[526367093] 'agreement among raft nodes before linearized reading' (duration: 285.595245ms)","trace[526367093] 'count revisions from in-memory index tree' (duration: 46.742462ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.534263Z","caller":"traceutil/trace.go:171","msg":"trace[1822650150] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"583.59132ms","start":"2026-04-07T09:43:30.950661Z","end":"2026-04-07T09:43:31.534253Z","steps":["trace[1822650150] 'agreement among raft nodes before linearized reading' (duration: 537.386271ms)","trace[1822650150] 'range keys from in-memory index tree' (duration: 46.167187ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.53459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.156802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.533658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.180854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.535223Z","caller":"traceutil/trace.go:171","msg":"trace[824303410] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:625; }","duration":"129.760982ms","start":"2026-04-07T09:43:31.405445Z","end":"2026-04-07T09:43:31.535206Z","steps":["trace[824303410] 'agreement among raft nodes before linearized reading' (duration: 82.393685ms)","trace[824303410] 'range keys from in-memory index tree' (duration: 45.802469ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.534288Z","caller":"traceutil/trace.go:171","msg":"trace[155368276] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:625; }","duration":"492.309101ms","start":"2026-04-07T09:43:31.041958Z","end":"2026-04-07T09:43:31.534267Z","steps":["trace[155368276] 'agreement among raft nodes before linearized reading' (duration: 446.03256ms)","trace[155368276] 'range keys from in-memory index tree' (duration: 46.220329ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.535295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.041937Z","time spent":"493.346975ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:43:31.534739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.269084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.535396Z","caller":"traceutil/trace.go:171","msg":"trace[1309366427] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:625; }","duration":"494.042173ms","start":"2026-04-07T09:43:31.041345Z","end":"2026-04-07T09:43:31.535387Z","steps":["trace[1309366427] 'agreement among raft nodes before linearized reading' (duration: 446.672266ms)","trace[1309366427] 'range keys from in-memory index tree' (duration: 46.612319ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.535426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.041325Z","time spent":"494.091233ms","remote":"127.0.0.1:55014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"info","ts":"2026-04-07T09:43:31.534807Z","caller":"traceutil/trace.go:171","msg":"trace[672501066] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:625; }","duration":"147.279915ms","start":"2026-04-07T09:43:31.387516Z","end":"2026-04-07T09:43:31.534796Z","steps":["trace[672501066] 'agreement among raft nodes before linearized reading' (duration: 100.37801ms)","trace[672501066] 'range keys from in-memory index tree' (duration: 46.150667ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.45483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.535616Z","caller":"traceutil/trace.go:171","msg":"trace[1116140226] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:625; }","duration":"708.898535ms","start":"2026-04-07T09:43:30.826705Z","end":"2026-04-07T09:43:31.535604Z","steps":["trace[1116140226] 'agreement among raft nodes before linearized reading' (duration: 661.335723ms)","trace[1116140226] 'range keys from in-memory index tree' (duration: 46.136727ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.535656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.826687Z","time spent":"708.956916ms","remote":"127.0.0.1:54946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:43:31.53427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.715082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.53576Z","caller":"traceutil/trace.go:171","msg":"trace[240849351] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:625; }","duration":"179.221529ms","start":"2026-04-07T09:43:31.356518Z","end":"2026-04-07T09:43:31.53574Z","steps":["trace[240849351] 'agreement among raft nodes before linearized reading' (duration: 131.390261ms)","trace[240849351] 'count revisions from in-memory index tree' (duration: 46.342072ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.808445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.53585Z","caller":"traceutil/trace.go:171","msg":"trace[1482038094] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:625; }","duration":"179.373493ms","start":"2026-04-07T09:43:31.356458Z","end":"2026-04-07T09:43:31.535831Z","steps":["trace[1482038094] 'agreement among raft nodes before linearized reading' (duration: 131.459213ms)","trace[1482038094] 'range keys from in-memory index tree' (duration: 46.368043ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.534305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.920624Z","time spent":"613.673218ms","remote":"127.0.0.1:54976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.534146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.202474Z","time spent":"331.64146ms","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":105,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.534346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.683937ms","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":"warn","ts":"2026-04-07T09:43:31.53432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.241401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T09:43:31.536087Z","caller":"traceutil/trace.go:171","msg":"trace[517004949] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:625; }","duration":"439.41193ms","start":"2026-04-07T09:43:31.096644Z","end":"2026-04-07T09:43:31.536056Z","steps":["trace[517004949] 'agreement among raft nodes before linearized reading' (duration: 391.413208ms)","trace[517004949] 'range keys from in-memory index tree' (duration: 46.2725ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.53603Z","caller":"traceutil/trace.go:171","msg":"trace[1630689349] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:625; }","duration":"740.692624ms","start":"2026-04-07T09:43:30.79438Z","end":"2026-04-07T09:43:31.535072Z","steps":["trace[1630689349] 'agreement among raft nodes before linearized reading' (duration: 693.590914ms)","trace[1630689349] 'range keys from in-memory index tree' (duration: 46.564368ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:31.536122Z","caller":"traceutil/trace.go:171","msg":"trace[2102568815] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"371.073995ms","start":"2026-04-07T09:43:31.165037Z","end":"2026-04-07T09:43:31.536111Z","steps":["trace[2102568815] 'agreement among raft nodes before linearized reading' (duration: 323.007571ms)","trace[2102568815] 'range keys from in-memory index tree' (duration: 46.230589ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.536131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.096639Z","time spent":"439.476061ms","remote":"127.0.0.1:55026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:43:31.534349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.839632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.536204Z","caller":"traceutil/trace.go:171","msg":"trace[1766886225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"615.717448ms","start":"2026-04-07T09:43:30.920474Z","end":"2026-04-07T09:43:31.536191Z","steps":["trace[1766886225] 'agreement among raft nodes before linearized reading' (duration: 567.47948ms)","trace[1766886225] 'range keys from in-memory index tree' (duration: 46.381693ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.536226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.794355Z","time spent":"741.846662ms","remote":"127.0.0.1:54932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.536246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.920453Z","time spent":"615.7802ms","remote":"127.0.0.1:54976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:43:31.534374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.097543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:43:31.534396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.097938ms","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-04-07T09:43:31.536424Z","caller":"traceutil/trace.go:171","msg":"trace[829495425] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:625; }","duration":"655.133263ms","start":"2026-04-07T09:43:30.881211Z","end":"2026-04-07T09:43:31.536344Z","steps":["trace[829495425] 'agreement among raft nodes before linearized reading' (duration: 606.755761ms)","trace[829495425] 'range keys from in-memory index tree' (duration: 46.394303ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.536637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.881184Z","time spent":"655.413139ms","remote":"127.0.0.1:54970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"info","ts":"2026-04-07T09:43:31.536458Z","caller":"traceutil/trace.go:171","msg":"trace[719862513] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:625; }","duration":"440.172948ms","start":"2026-04-07T09:43:31.096272Z","end":"2026-04-07T09:43:31.536444Z","steps":["trace[719862513] 'agreement among raft nodes before linearized reading' (duration: 391.790437ms)","trace[719862513] 'count revisions from in-memory index tree' (duration: 46.312371ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.536799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.096253Z","time spent":"440.518346ms","remote":"127.0.0.1:55026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.534443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.865436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:43:31.536909Z","caller":"traceutil/trace.go:171","msg":"trace[1418591966] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:625; }","duration":"372.341225ms","start":"2026-04-07T09:43:31.16455Z","end":"2026-04-07T09:43:31.536891Z","steps":["trace[1418591966] 'agreement among raft nodes before linearized reading' (duration: 323.518813ms)","trace[1418591966] 'range keys from in-memory index tree' (duration: 46.337522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.536961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.164527Z","time spent":"372.419297ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:43:31.533274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.428857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.537064Z","caller":"traceutil/trace.go:171","msg":"trace[743660397] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:625; }","duration":"535.285701ms","start":"2026-04-07T09:43:31.001763Z","end":"2026-04-07T09:43:31.537049Z","steps":["trace[743660397] 'agreement among raft nodes before linearized reading' (duration: 486.265004ms)","trace[743660397] 'count revisions from in-memory index tree' (duration: 45.177994ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.537107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.001737Z","time spent":"535.358643ms","remote":"127.0.0.1:55008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.534814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.795261Z","time spent":"739.543227ms","remote":"127.0.0.1:54926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:43:31.535034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.950651Z","time spent":"584.372859ms","remote":"127.0.0.1:54976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-04-07T09:43:31.534983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.202392Z","time spent":"332.580363ms","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.536161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:31.165015Z","time spent":"371.136926ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T09:43:31.534368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.99417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.537366Z","caller":"traceutil/trace.go:171","msg":"trace[2016110168] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:625; }","duration":"587.030793ms","start":"2026-04-07T09:43:30.950316Z","end":"2026-04-07T09:43:31.537347Z","steps":["trace[2016110168] 'agreement among raft nodes before linearized reading' (duration: 537.7403ms)","trace[2016110168] 'count revisions from in-memory index tree' (duration: 46.293831ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.537421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.950292Z","time spent":"587.110166ms","remote":"127.0.0.1:54992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:31.5344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.3002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:31.53751Z","caller":"traceutil/trace.go:171","msg":"trace[1270450144] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:625; }","duration":"711.385414ms","start":"2026-04-07T09:43:30.826094Z","end":"2026-04-07T09:43:31.537479Z","steps":["trace[1270450144] 'agreement among raft nodes before linearized reading' (duration: 661.870845ms)","trace[1270450144] 'count revisions from in-memory index tree' (duration: 46.411194ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:43:31.537585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:30.825993Z","time spent":"711.570409ms","remote":"127.0.0.1:54946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:43:32.93701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.442039ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:43:32.937175Z","caller":"traceutil/trace.go:171","msg":"trace[64531551] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"212.962256ms","start":"2026-04-07T09:43:32.724177Z","end":"2026-04-07T09:43:32.937139Z","steps":["trace[64531551] 'process raft request' (duration: 13.329842ms)","trace[64531551] 'compare' (duration: 199.304396ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:33.343171Z","caller":"traceutil/trace.go:171","msg":"trace[2094373208] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"389.559983ms","start":"2026-04-07T09:43:32.953579Z","end":"2026-04-07T09:43:33.343139Z","steps":["trace[2094373208] 'read index received' (duration: 388.22671ms)","trace[2094373208] 'applied index is now lower than readState.Index' (duration: 1.331923ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:33.343195Z","caller":"traceutil/trace.go:171","msg":"trace[200700532] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"402.594078ms","start":"2026-04-07T09:43:32.940576Z","end":"2026-04-07T09:43:33.34317Z","steps":["trace[200700532] 'process raft request' (duration: 401.234635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:33.343405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:32.940547Z","time spent":"402.778332ms","remote":"127.0.0.1:37494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":763,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:43:33.343417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.875538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:33.343469Z","caller":"traceutil/trace.go:171","msg":"trace[927865715] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:642; }","duration":"258.931829ms","start":"2026-04-07T09:43:33.084522Z","end":"2026-04-07T09:43:33.343454Z","steps":["trace[927865715] 'agreement among raft nodes before linearized reading' (duration: 258.821647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:33.343513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.900531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:43:33.343685Z","caller":"traceutil/trace.go:171","msg":"trace[1883128593] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:642; }","duration":"390.099555ms","start":"2026-04-07T09:43:32.953547Z","end":"2026-04-07T09:43:33.343646Z","steps":["trace[1883128593] 'agreement among raft nodes before linearized reading' (duration: 389.705885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:33.343852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:43:32.953533Z","time spent":"390.30007ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T09:43:34.670567Z","caller":"traceutil/trace.go:171","msg":"trace[1356511875] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"108.760054ms","start":"2026-04-07T09:43:34.561776Z","end":"2026-04-07T09:43:34.670536Z","steps":["trace[1356511875] 'process raft request' (duration: 56.13209ms)","trace[1356511875] 'compare' (duration: 52.452279ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:34.671746Z","caller":"traceutil/trace.go:171","msg":"trace[1914798192] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"102.719088ms","start":"2026-04-07T09:43:34.569012Z","end":"2026-04-07T09:43:34.671731Z","steps":["trace[1914798192] 'process raft request' (duration: 102.614435ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:48.743857Z","caller":"traceutil/trace.go:171","msg":"trace[56936760] linearizableReadLoop","detail":"{readStateIndex:825; appliedIndex:824; }","duration":"121.726967ms","start":"2026-04-07T09:43:48.622111Z","end":"2026-04-07T09:43:48.743838Z","steps":["trace[56936760] 'read index received' (duration: 121.583494ms)","trace[56936760] 'applied index is now lower than readState.Index' (duration: 142.843µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:43:48.743937Z","caller":"traceutil/trace.go:171","msg":"trace[2069334922] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"251.095089ms","start":"2026-04-07T09:43:48.49283Z","end":"2026-04-07T09:43:48.743925Z","steps":["trace[2069334922] 'process raft request' (duration: 250.879274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:43:48.744045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.917542ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwbdd\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-04-07T09:43:48.744075Z","caller":"traceutil/trace.go:171","msg":"trace[316231233] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwbdd; range_end:; response_count:1; response_revision:794; }","duration":"122.021475ms","start":"2026-04-07T09:43:48.622045Z","end":"2026-04-07T09:43:48.744067Z","steps":["trace[316231233] 'agreement among raft nodes before linearized reading' (duration: 121.893442ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:43:48.857045Z","caller":"traceutil/trace.go:171","msg":"trace[749451461] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"104.232204ms","start":"2026-04-07T09:43:48.752713Z","end":"2026-04-07T09:43:48.856945Z","steps":["trace[749451461] 'process raft request' (duration: 100.025862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:13.983264Z","caller":"traceutil/trace.go:171","msg":"trace[444534864] linearizableReadLoop","detail":"{readStateIndex:1201; appliedIndex:1200; }","duration":"171.628716ms","start":"2026-04-07T09:44:13.811603Z","end":"2026-04-07T09:44:13.983231Z","steps":["trace[444534864] 'read index received' (duration: 171.39795ms)","trace[444534864] 'applied index is now lower than readState.Index' (duration: 229.616µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:13.983371Z","caller":"traceutil/trace.go:171","msg":"trace[361569499] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"373.289869ms","start":"2026-04-07T09:44:13.610032Z","end":"2026-04-07T09:44:13.983322Z","steps":["trace[361569499] 'process raft request' (duration: 373.030833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.983531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.899182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T09:44:13.983562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.909432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T09:44:13.983551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:13.610007Z","time spent":"373.452363ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:13.983603Z","caller":"traceutil/trace.go:171","msg":"trace[905298492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1164; }","duration":"171.951133ms","start":"2026-04-07T09:44:13.811641Z","end":"2026-04-07T09:44:13.983592Z","steps":["trace[905298492] 'agreement among raft nodes before linearized reading' (duration: 171.863891ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:13.983535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.913032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T09:44:13.983609Z","caller":"traceutil/trace.go:171","msg":"trace[455475165] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1164; }","duration":"172.021265ms","start":"2026-04-07T09:44:13.811567Z","end":"2026-04-07T09:44:13.983588Z","steps":["trace[455475165] 'agreement among raft nodes before linearized reading' (duration: 171.826041ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:13.983812Z","caller":"traceutil/trace.go:171","msg":"trace[1882282977] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1164; }","duration":"172.1954ms","start":"2026-04-07T09:44:13.811568Z","end":"2026-04-07T09:44:13.983764Z","steps":["trace[1882282977] 'agreement among raft nodes before linearized reading' (duration: 171.81424ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:20.083578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000384652s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-07T09:44:20.083703Z","caller":"traceutil/trace.go:171","msg":"trace[438836204] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000556975s","start":"2026-04-07T09:44:18.083116Z","end":"2026-04-07T09:44:20.083673Z","steps":["trace[438836204] 'agreement among raft nodes before linearized reading' (duration: 2.000383981s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:20.083768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.083103Z","time spent":"2.000652237s","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:44:21.11419Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.993195035s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T09:44:21.195009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.073905302s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:21.195342Z","caller":"traceutil/trace.go:171","msg":"trace[15327523] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1226; }","duration":"3.112170661s","start":"2026-04-07T09:44:18.083151Z","end":"2026-04-07T09:44:21.195321Z","steps":["trace[15327523] 'read index received' (duration: 37.858999ms)","trace[15327523] 'applied index is now lower than readState.Index' (duration: 3.074310372s)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:21.195422Z","caller":"traceutil/trace.go:171","msg":"trace[671195298] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"3.117676023s","start":"2026-04-07T09:44:18.077735Z","end":"2026-04-07T09:44:21.195411Z","steps":["trace[671195298] 'process raft request' (duration: 43.254129ms)","trace[671195298] 'compare' (duration: 3.072808235s)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:21.195474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.077711Z","time spent":"3.117731625s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:21.195869Z","caller":"traceutil/trace.go:171","msg":"trace[1392366512] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"3.11756746s","start":"2026-04-07T09:44:18.078232Z","end":"2026-04-07T09:44:21.195799Z","steps":["trace[1392366512] 'process raft request' (duration: 3.116997647s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.195978Z","caller":"traceutil/trace.go:171","msg":"trace[1022123971] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"3.118027102s","start":"2026-04-07T09:44:18.077924Z","end":"2026-04-07T09:44:21.195951Z","steps":["trace[1022123971] 'process raft request' (duration: 3.117210652s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.196097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.078205Z","time spent":"3.117776176s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.196118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.07789Z","time spent":"3.118145634s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:21.270936Z","caller":"traceutil/trace.go:171","msg":"trace[1208690810] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"3.075660794s","start":"2026-04-07T09:44:18.195242Z","end":"2026-04-07T09:44:21.270903Z","steps":["trace[1208690810] 'process raft request' (duration: 3.075442459s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.271098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.195202Z","time spent":"3.075814258s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:21.271216Z","caller":"traceutil/trace.go:171","msg":"trace[921219421] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"1.635688941s","start":"2026-04-07T09:44:19.635494Z","end":"2026-04-07T09:44:21.271183Z","steps":["trace[921219421] 'process raft request' (duration: 1.635369373s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.27142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:19.635455Z","time spent":"1.635851435s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:21.360574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.477873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:21.360674Z","caller":"traceutil/trace.go:171","msg":"trace[59718759] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"618.629666ms","start":"2026-04-07T09:44:20.742014Z","end":"2026-04-07T09:44:21.360644Z","steps":["trace[59718759] 'agreement among raft nodes before linearized reading' (duration: 618.486273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.360725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.741988Z","time spent":"618.727779ms","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:44:21.360755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.986082522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T09:44:21.360916Z","caller":"traceutil/trace.go:171","msg":"trace[92614488] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1193; }","duration":"2.986279097s","start":"2026-04-07T09:44:18.374621Z","end":"2026-04-07T09:44:21.3609Z","steps":["trace[92614488] 'agreement among raft nodes before linearized reading' (duration: 2.986005261s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.360729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.276447784s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:44:21.360971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:18.374593Z","time spent":"2.98636726s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T09:44:21.360513Z","caller":"traceutil/trace.go:171","msg":"trace[589436826] linearizableReadLoop","detail":"{readStateIndex:1232; appliedIndex:1229; }","duration":"165.110935ms","start":"2026-04-07T09:44:21.195372Z","end":"2026-04-07T09:44:21.360483Z","steps":["trace[589436826] 'read index received' (duration: 75.34642ms)","trace[589436826] 'applied index is now lower than readState.Index' (duration: 89.763065ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:21.361043Z","caller":"traceutil/trace.go:171","msg":"trace[1042760210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1193; }","duration":"1.276830593s","start":"2026-04-07T09:44:20.084179Z","end":"2026-04-07T09:44:21.36101Z","steps":["trace[1042760210] 'agreement among raft nodes before linearized reading' (duration: 1.276411723s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.361021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.28331717s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T09:44:21.361311Z","caller":"traceutil/trace.go:171","msg":"trace[1943857782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1193; }","duration":"1.283714579s","start":"2026-04-07T09:44:20.077581Z","end":"2026-04-07T09:44:21.361296Z","steps":["trace[1943857782] 'agreement among raft nodes before linearized reading' (duration: 1.283101474s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.361351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.077552Z","time spent":"1.283786571s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T09:44:21.361678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:20.084147Z","time spent":"1.277062619s","remote":"127.0.0.1:37424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T09:44:21.499761Z","caller":"traceutil/trace.go:171","msg":"trace[287554755] transaction","detail":"{read_only:false; response_revision:1194; number_of_response:1; }","duration":"134.237584ms","start":"2026-04-07T09:44:21.365496Z","end":"2026-04-07T09:44:21.499734Z","steps":["trace[287554755] 'process raft request' (duration: 134.05916ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.663123Z","caller":"traceutil/trace.go:171","msg":"trace[1888026072] linearizableReadLoop","detail":"{readStateIndex:1235; appliedIndex:1232; }","duration":"292.617558ms","start":"2026-04-07T09:44:21.370473Z","end":"2026-04-07T09:44:21.66309Z","steps":["trace[1888026072] 'read index received' (duration: 129.116621ms)","trace[1888026072] 'applied index is now lower than readState.Index' (duration: 163.499647ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:21.663162Z","caller":"traceutil/trace.go:171","msg":"trace[1973167619] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"296.8982ms","start":"2026-04-07T09:44:21.366207Z","end":"2026-04-07T09:44:21.663106Z","steps":["trace[1973167619] 'process raft request' (duration: 205.624558ms)","trace[1973167619] 'compare' (duration: 90.959274ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:21.663257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.763141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:21.663295Z","caller":"traceutil/trace.go:171","msg":"trace[1382500575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1196; }","duration":"292.849833ms","start":"2026-04-07T09:44:21.370434Z","end":"2026-04-07T09:44:21.663284Z","steps":["trace[1382500575] 'agreement among raft nodes before linearized reading' (duration: 292.770921ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:21.663279Z","caller":"traceutil/trace.go:171","msg":"trace[222330240] transaction","detail":"{read_only:false; response_revision:1196; number_of_response:1; }","duration":"296.989973ms","start":"2026-04-07T09:44:21.366234Z","end":"2026-04-07T09:44:21.663224Z","steps":["trace[222330240] 'process raft request' (duration: 296.770337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:21.902078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.276129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/cert-manager/cmapichecker-hpcrq\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:21.902313Z","caller":"traceutil/trace.go:171","msg":"trace[900119704] range","detail":"{range_begin:/registry/cert-manager.io/certificates/cert-manager/cmapichecker-hpcrq; range_end:; response_count:0; response_revision:1196; }","duration":"100.575956ms","start":"2026-04-07T09:44:21.801719Z","end":"2026-04-07T09:44:21.902295Z","steps":["trace[900119704] 'range keys from in-memory index tree' (duration: 100.139196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:22.553177Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085743851650654323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:23.053362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085743851650654323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:23.554214Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085743851650654323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:24.055199Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085743851650654323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:24.085199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999534207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T09:44:24.085567Z","caller":"traceutil/trace.go:171","msg":"trace[830197442] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999984747s","start":"2026-04-07T09:44:22.085563Z","end":"2026-04-07T09:44:24.085547Z","steps":["trace[830197442] 'agreement among raft nodes before linearized reading' (duration: 1.999584428s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:24.085615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:22.085519Z","time spent":"2.00008548s","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 09:44:24 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T09:44:24.555883Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14085743851650654323,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:44:24.753095Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.770813944s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T09:44:24.753568Z","caller":"traceutil/trace.go:171","msg":"trace[15086383] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"2.735724336s","start":"2026-04-07T09:44:22.01781Z","end":"2026-04-07T09:44:24.753534Z","steps":["trace[15086383] 'process raft request' (duration: 2.735509901s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:24.753807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:22.017787Z","time spent":"2.735881939s","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2914,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:25.538046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.974173ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:25.53818Z","caller":"traceutil/trace.go:171","msg":"trace[1469832678] linearizableReadLoop","detail":"{readStateIndex:1237; appliedIndex:1235; }","duration":"3.485493801s","start":"2026-04-07T09:44:22.052668Z","end":"2026-04-07T09:44:25.538162Z","steps":["trace[1469832678] 'read index received' (duration: 2.700642553s)","trace[1469832678] 'applied index is now lower than readState.Index' (duration: 784.849848ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:25.538304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.485634284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:44:25.53833Z","caller":"traceutil/trace.go:171","msg":"trace[1177777983] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1198; }","duration":"3.485683285s","start":"2026-04-07T09:44:22.052639Z","end":"2026-04-07T09:44:25.538322Z","steps":["trace[1177777983] 'agreement among raft nodes before linearized reading' (duration: 3.485621573s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.538291Z","caller":"traceutil/trace.go:171","msg":"trace[2031108628] transaction","detail":"{read_only:false; response_revision:1198; number_of_response:1; }","duration":"2.260259557s","start":"2026-04-07T09:44:23.277986Z","end":"2026-04-07T09:44:25.538245Z","steps":["trace[2031108628] 'process raft request' (duration: 2.136977216s)","trace[2031108628] 'compare' (duration: 122.582414ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:25.538406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.222496024s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:44:25.538432Z","caller":"traceutil/trace.go:171","msg":"trace[749894773] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1198; }","duration":"3.222563746s","start":"2026-04-07T09:44:22.315863Z","end":"2026-04-07T09:44:25.538427Z","steps":["trace[749894773] 'agreement among raft nodes before linearized reading' (duration: 3.222523545s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.53845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:22.315838Z","time spent":"3.222607277s","remote":"127.0.0.1:37780","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:25.538537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.277948Z","time spent":"2.260456131s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:25.53868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.033269326s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T09:44:25.538706Z","caller":"traceutil/trace.go:171","msg":"trace[1667402316] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1198; }","duration":"2.033337569s","start":"2026-04-07T09:44:23.505362Z","end":"2026-04-07T09:44:25.5387Z","steps":["trace[1667402316] 'agreement among raft nodes before linearized reading' (duration: 2.033271507s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.538669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.869922444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-07T09:44:25.538356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:22.052624Z","time spent":"3.485725776s","remote":"127.0.0.1:37532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":7,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:25.538779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.278083275s","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-04-07T09:44:25.538803Z","caller":"traceutil/trace.go:171","msg":"trace[1620275541] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1198; }","duration":"2.278148507s","start":"2026-04-07T09:44:23.26065Z","end":"2026-04-07T09:44:25.538798Z","steps":["trace[1620275541] 'agreement among raft nodes before linearized reading' (duration: 2.278087175s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.538822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.260623Z","time spent":"2.278194858s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":550,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-04-07T09:44:25.538957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.615407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T09:44:25.538996Z","caller":"traceutil/trace.go:171","msg":"trace[234449474] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:1198; }","duration":"242.72878ms","start":"2026-04-07T09:44:25.296258Z","end":"2026-04-07T09:44:25.538987Z","steps":["trace[234449474] 'agreement among raft nodes before linearized reading' (duration: 242.578126ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.538726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.505335Z","time spent":"2.033386979s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T09:44:25.539156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.228336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwbdd\" ","response":"range_response_count:1 size:4126"} {"level":"info","ts":"2026-04-07T09:44:25.53919Z","caller":"traceutil/trace.go:171","msg":"trace[1819837130] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwbdd; range_end:; response_count:1; response_revision:1198; }","duration":"780.302678ms","start":"2026-04-07T09:44:24.758878Z","end":"2026-04-07T09:44:25.539181Z","steps":["trace[1819837130] 'agreement among raft nodes before linearized reading' (duration: 780.208816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.539208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:24.758859Z","time spent":"780.3441ms","remote":"127.0.0.1:37598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":4148,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwbdd\" "} {"level":"info","ts":"2026-04-07T09:44:25.538774Z","caller":"traceutil/trace.go:171","msg":"trace[1983401004] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1198; }","duration":"1.870086428s","start":"2026-04-07T09:44:23.668673Z","end":"2026-04-07T09:44:25.538759Z","steps":["trace[1983401004] 'agreement among raft nodes before linearized reading' (duration: 1.869805571s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.53926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.338802123s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-04-07T09:44:25.539326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"780.226776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-04-07T09:44:25.539358Z","caller":"traceutil/trace.go:171","msg":"trace[1371788711] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1198; }","duration":"2.338947757s","start":"2026-04-07T09:44:23.200389Z","end":"2026-04-07T09:44:25.539336Z","steps":["trace[1371788711] 'agreement among raft nodes before linearized reading' (duration: 2.338726472s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.539378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.453784761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:44:25.539423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.200366Z","time spent":"2.339049139s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-07T09:44:25.539433Z","caller":"traceutil/trace.go:171","msg":"trace[101221991] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1198; }","duration":"780.409321ms","start":"2026-04-07T09:44:24.758994Z","end":"2026-04-07T09:44:25.539404Z","steps":["trace[101221991] 'agreement among raft nodes before linearized reading' (duration: 780.101913ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.53946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.338118276s","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-04-07T09:44:25.53947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.668641Z","time spent":"1.870726883s","remote":"127.0.0.1:37670","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-04-07T09:44:25.539516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:24.758966Z","time spent":"780.535914ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":2951,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-04-07T09:44:25.539528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.310211826s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:25.539549Z","caller":"traceutil/trace.go:171","msg":"trace[553551699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1198; }","duration":"2.338209389s","start":"2026-04-07T09:44:23.20132Z","end":"2026-04-07T09:44:25.53953Z","steps":["trace[553551699] 'agreement among raft nodes before linearized reading' (duration: 2.337881751s)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.53961Z","caller":"traceutil/trace.go:171","msg":"trace[1800287511] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1198; }","duration":"2.310290728s","start":"2026-04-07T09:44:23.229306Z","end":"2026-04-07T09:44:25.539597Z","steps":["trace[1800287511] 'agreement among raft nodes before linearized reading' (duration: 2.310192536s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.539661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.229233Z","time spent":"2.310418292s","remote":"127.0.0.1:37720","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":27,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:44:25.539636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.338339503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:44:25.539732Z","caller":"traceutil/trace.go:171","msg":"trace[1760638035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1198; }","duration":"2.338490886s","start":"2026-04-07T09:44:23.20122Z","end":"2026-04-07T09:44:25.539711Z","steps":["trace[1760638035] 'agreement among raft nodes before linearized reading' (duration: 2.338001814s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.539989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.201195Z","time spent":"2.338587538s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:44:25.539632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:23.201254Z","time spent":"2.338360583s","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T09:44:25.541343Z","caller":"traceutil/trace.go:171","msg":"trace[825493363] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1198; }","duration":"1.455845321s","start":"2026-04-07T09:44:24.085472Z","end":"2026-04-07T09:44:25.541318Z","steps":["trace[825493363] 'agreement among raft nodes before linearized reading' (duration: 1.45372186s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.541417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:24.085448Z","time spent":"1.455953913s","remote":"127.0.0.1:37424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T09:44:25.841073Z","caller":"traceutil/trace.go:171","msg":"trace[221731177] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"294.953143ms","start":"2026-04-07T09:44:25.546091Z","end":"2026-04-07T09:44:25.841044Z","steps":["trace[221731177] 'process raft request' (duration: 294.897721ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.841112Z","caller":"traceutil/trace.go:171","msg":"trace[372988518] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"295.128977ms","start":"2026-04-07T09:44:25.545939Z","end":"2026-04-07T09:44:25.841068Z","steps":["trace[372988518] 'process raft request' (duration: 294.84838ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.84144Z","caller":"traceutil/trace.go:171","msg":"trace[1368848710] transaction","detail":"{read_only:false; response_revision:1201; number_of_response:1; }","duration":"295.181728ms","start":"2026-04-07T09:44:25.546215Z","end":"2026-04-07T09:44:25.841397Z","steps":["trace[1368848710] 'process raft request' (duration: 294.798599ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.841559Z","caller":"traceutil/trace.go:171","msg":"trace[1341211202] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"294.43227ms","start":"2026-04-07T09:44:25.547118Z","end":"2026-04-07T09:44:25.84155Z","steps":["trace[1341211202] 'process raft request' (duration: 294.339928ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.84154Z","caller":"traceutil/trace.go:171","msg":"trace[1681607327] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1238; }","duration":"255.215899ms","start":"2026-04-07T09:44:25.586292Z","end":"2026-04-07T09:44:25.841508Z","steps":["trace[1681607327] 'read index received' (duration: 254.4526ms)","trace[1681607327] 'applied index is now lower than readState.Index' (duration: 761.809µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:25.841491Z","caller":"traceutil/trace.go:171","msg":"trace[65245141] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"295.141857ms","start":"2026-04-07T09:44:25.546325Z","end":"2026-04-07T09:44:25.841467Z","steps":["trace[65245141] 'process raft request' (duration: 294.972463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.841689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.220649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:25.841513Z","caller":"traceutil/trace.go:171","msg":"trace[423935945] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"295.012564ms","start":"2026-04-07T09:44:25.546492Z","end":"2026-04-07T09:44:25.841505Z","steps":["trace[423935945] 'process raft request' (duration: 294.933102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:25.841678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.559657ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18a409ebc7be6ea3\" ","response":"range_response_count:1 size:774"} {"level":"warn","ts":"2026-04-07T09:44:25.841776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.161881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2929"} {"level":"info","ts":"2026-04-07T09:44:25.841802Z","caller":"traceutil/trace.go:171","msg":"trace[381350107] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1204; }","duration":"290.374992ms","start":"2026-04-07T09:44:25.551402Z","end":"2026-04-07T09:44:25.841777Z","steps":["trace[381350107] 'agreement among raft nodes before linearized reading' (duration: 290.139587ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.84183Z","caller":"traceutil/trace.go:171","msg":"trace[959837614] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1204; }","duration":"296.300025ms","start":"2026-04-07T09:44:25.545519Z","end":"2026-04-07T09:44:25.84182Z","steps":["trace[959837614] 'agreement among raft nodes before linearized reading' (duration: 296.10114ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:25.841843Z","caller":"traceutil/trace.go:171","msg":"trace[121797686] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18a409ebc7be6ea3; range_end:; response_count:1; response_revision:1204; }","duration":"295.744941ms","start":"2026-04-07T09:44:25.546076Z","end":"2026-04-07T09:44:25.841821Z","steps":["trace[121797686] 'agreement among raft nodes before linearized reading' (duration: 295.466305ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:26.102728Z","caller":"traceutil/trace.go:171","msg":"trace[627723323] linearizableReadLoop","detail":"{readStateIndex:1246; appliedIndex:1244; }","duration":"259.388488ms","start":"2026-04-07T09:44:25.843314Z","end":"2026-04-07T09:44:26.102703Z","steps":["trace[627723323] 'read index received' (duration: 259.261645ms)","trace[627723323] 'applied index is now lower than readState.Index' (duration: 125.083µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:26.102835Z","caller":"traceutil/trace.go:171","msg":"trace[1916576671] transaction","detail":"{read_only:false; response_revision:1206; number_of_response:1; }","duration":"511.674746ms","start":"2026-04-07T09:44:25.591149Z","end":"2026-04-07T09:44:26.102823Z","steps":["trace[1916576671] 'process raft request' (duration: 511.497752ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:26.102864Z","caller":"traceutil/trace.go:171","msg":"trace[1946425984] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"515.211361ms","start":"2026-04-07T09:44:25.587599Z","end":"2026-04-07T09:44:26.10281Z","steps":["trace[1946425984] 'process raft request' (duration: 514.847162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.102956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.591126Z","time spent":"511.736918ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:26.103139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:25.587566Z","time spent":"515.415786ms","remote":"127.0.0.1:37442","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:26.103361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.634224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:26.103505Z","caller":"traceutil/trace.go:171","msg":"trace[2091832162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1206; }","duration":"260.225218ms","start":"2026-04-07T09:44:25.843252Z","end":"2026-04-07T09:44:26.103478Z","steps":["trace[2091832162] 'agreement among raft nodes before linearized reading' (duration: 259.597173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.140325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.078047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:44:26.140532Z","caller":"traceutil/trace.go:171","msg":"trace[1755652831] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"100.842402ms","start":"2026-04-07T09:44:26.039657Z","end":"2026-04-07T09:44:26.1405Z","steps":["trace[1755652831] 'process raft request' (duration: 100.439602ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:26.140553Z","caller":"traceutil/trace.go:171","msg":"trace[1600120400] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1208; }","duration":"278.379374ms","start":"2026-04-07T09:44:25.86215Z","end":"2026-04-07T09:44:26.140529Z","steps":["trace[1600120400] 'agreement among raft nodes before linearized reading' (duration: 278.051957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.140456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.754517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwbdd\" ","response":"range_response_count:1 size:4126"} {"level":"info","ts":"2026-04-07T09:44:26.14086Z","caller":"traceutil/trace.go:171","msg":"trace[1026507282] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-dwbdd; range_end:; response_count:1; response_revision:1208; }","duration":"295.186058ms","start":"2026-04-07T09:44:25.845657Z","end":"2026-04-07T09:44:26.140843Z","steps":["trace[1026507282] 'agreement among raft nodes before linearized reading' (duration: 294.678856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.140444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.563768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/cert-manager/cert-manager-startupapicheck-wzzgg\" ","response":"range_response_count:1 size:3979"} {"level":"info","ts":"2026-04-07T09:44:26.140551Z","caller":"traceutil/trace.go:171","msg":"trace[2087612715] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"295.548436ms","start":"2026-04-07T09:44:25.844975Z","end":"2026-04-07T09:44:26.140524Z","steps":["trace[2087612715] 'process raft request' (duration: 294.88531ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:26.140981Z","caller":"traceutil/trace.go:171","msg":"trace[680153297] range","detail":"{range_begin:/registry/pods/cert-manager/cert-manager-startupapicheck-wzzgg; range_end:; response_count:1; response_revision:1208; }","duration":"102.138242ms","start":"2026-04-07T09:44:26.038804Z","end":"2026-04-07T09:44:26.140942Z","steps":["trace[680153297] 'agreement among raft nodes before linearized reading' (duration: 101.415005ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:26.399964Z","caller":"traceutil/trace.go:171","msg":"trace[662396720] linearizableReadLoop","detail":"{readStateIndex:1249; appliedIndex:1248; }","duration":"254.86682ms","start":"2026-04-07T09:44:26.145066Z","end":"2026-04-07T09:44:26.399933Z","steps":["trace[662396720] 'read index received' (duration: 254.824259ms)","trace[662396720] 'applied index is now lower than readState.Index' (duration: 41.261µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:26.400067Z","caller":"traceutil/trace.go:171","msg":"trace[812821311] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"256.91634ms","start":"2026-04-07T09:44:26.143104Z","end":"2026-04-07T09:44:26.40002Z","steps":["trace[812821311] 'process raft request' (duration: 256.669344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.400164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.079545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-07T09:44:26.40022Z","caller":"traceutil/trace.go:171","msg":"trace[1157054297] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1209; }","duration":"255.172388ms","start":"2026-04-07T09:44:26.145029Z","end":"2026-04-07T09:44:26.400202Z","steps":["trace[1157054297] 'agreement among raft nodes before linearized reading' (duration: 255.034265ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:26.530607Z","caller":"traceutil/trace.go:171","msg":"trace[1058023970] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"379.660097ms","start":"2026-04-07T09:44:26.150918Z","end":"2026-04-07T09:44:26.530578Z","steps":["trace[1058023970] 'process raft request' (duration: 379.491883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.530798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:26.150899Z","time spent":"379.80189ms","remote":"127.0.0.1:37598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4150,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:26.558888Z","caller":"traceutil/trace.go:171","msg":"trace[1057640110] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1211; }","duration":"156.181701ms","start":"2026-04-07T09:44:26.402679Z","end":"2026-04-07T09:44:26.558861Z","steps":["trace[1057640110] 'process raft request' (duration: 155.997827ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:26.758259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.537829ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-07T09:44:26.75853Z","caller":"traceutil/trace.go:171","msg":"trace[1691461611] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1212; }","duration":"180.356001ms","start":"2026-04-07T09:44:26.578146Z","end":"2026-04-07T09:44:26.758469Z","steps":["trace[1691461611] 'compare' (duration: 156.382425ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.56741Z","caller":"traceutil/trace.go:171","msg":"trace[1452503231] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1213; }","duration":"111.650032ms","start":"2026-04-07T09:44:27.455736Z","end":"2026-04-07T09:44:27.567386Z","steps":["trace[1452503231] 'process raft request' (duration: 111.480447ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:27.893814Z","caller":"traceutil/trace.go:171","msg":"trace[1240245744] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"347.170037ms","start":"2026-04-07T09:44:27.54662Z","end":"2026-04-07T09:44:27.89379Z","steps":["trace[1240245744] 'process raft request' (duration: 347.068164ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.893962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.546592Z","time spent":"347.29804ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:27.893972Z","caller":"traceutil/trace.go:171","msg":"trace[968103427] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"355.865486ms","start":"2026-04-07T09:44:27.538059Z","end":"2026-04-07T09:44:27.893925Z","steps":["trace[968103427] 'process raft request' (duration: 355.476107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:27.8942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:27.538021Z","time spent":"356.03968ms","remote":"127.0.0.1:37646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3148,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:54.088005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.147102ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:54.089161Z","caller":"traceutil/trace.go:171","msg":"trace[1169085317] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"582.018706ms","start":"2026-04-07T09:44:53.507057Z","end":"2026-04-07T09:44:54.089075Z","steps":["trace[1169085317] 'process raft request' (duration: 461.42032ms)","trace[1169085317] 'compare' (duration: 118.941697ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:44:54.089327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:53.50701Z","time spent":"582.219222ms","remote":"127.0.0.1:37472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":111670,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:54.47855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.254917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:44:54.478823Z","caller":"traceutil/trace.go:171","msg":"trace[2006605521] transaction","detail":"{read_only:false; response_revision:1558; number_of_response:1; }","duration":"380.628291ms","start":"2026-04-07T09:44:54.098145Z","end":"2026-04-07T09:44:54.478773Z","steps":["trace[2006605521] 'process raft request' (duration: 212.962114ms)","trace[2006605521] 'compare' (duration: 166.988411ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:54.478957Z","caller":"traceutil/trace.go:171","msg":"trace[637877593] transaction","detail":"{read_only:false; response_revision:1559; number_of_response:1; }","duration":"380.733673ms","start":"2026-04-07T09:44:54.0982Z","end":"2026-04-07T09:44:54.478933Z","steps":["trace[637877593] 'process raft request' (duration: 380.510447ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.479039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.098093Z","time spent":"380.823775ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:54.479049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.098182Z","time spent":"380.830166ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:54.479275Z","caller":"traceutil/trace.go:171","msg":"trace[1504485508] transaction","detail":"{read_only:false; response_revision:1561; number_of_response:1; }","duration":"380.950919ms","start":"2026-04-07T09:44:54.098316Z","end":"2026-04-07T09:44:54.479267Z","steps":["trace[1504485508] 'process raft request' (duration: 380.810885ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:54.479254Z","caller":"traceutil/trace.go:171","msg":"trace[2005587040] transaction","detail":"{read_only:false; response_revision:1560; number_of_response:1; }","duration":"381.02404ms","start":"2026-04-07T09:44:54.098205Z","end":"2026-04-07T09:44:54.479229Z","steps":["trace[2005587040] 'process raft request' (duration: 380.684862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.479329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.098309Z","time spent":"380.99431ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:54.479306Z","caller":"traceutil/trace.go:171","msg":"trace[1030596323] transaction","detail":"{read_only:false; response_revision:1562; number_of_response:1; }","duration":"380.882317ms","start":"2026-04-07T09:44:54.098397Z","end":"2026-04-07T09:44:54.47928Z","steps":["trace[1030596323] 'process raft request' (duration: 380.826846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:54.47946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.098188Z","time spent":"381.150803ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:44:54.479787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:54.098391Z","time spent":"380.982009ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:55.055667Z","caller":"traceutil/trace.go:171","msg":"trace[858311187] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1562; }","duration":"113.138037ms","start":"2026-04-07T09:44:54.942495Z","end":"2026-04-07T09:44:55.055633Z","steps":["trace[858311187] 'process raft request' (duration: 113.008004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:55.530369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.345181ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-07T09:44:55.530589Z","caller":"traceutil/trace.go:171","msg":"trace[1702063187] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1562; }","duration":"205.802703ms","start":"2026-04-07T09:44:55.324761Z","end":"2026-04-07T09:44:55.530563Z","steps":["trace[1702063187] 'process raft request' (duration: 60.180935ms)","trace[1702063187] 'compare' (duration: 145.284009ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:55.530634Z","caller":"traceutil/trace.go:171","msg":"trace[1736561634] transaction","detail":"{read_only:false; response_revision:1563; number_of_response:1; }","duration":"188.338473ms","start":"2026-04-07T09:44:55.342278Z","end":"2026-04-07T09:44:55.530616Z","steps":["trace[1736561634] 'process raft request' (duration: 188.200939ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.756149Z","caller":"traceutil/trace.go:171","msg":"trace[867798263] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1563; }","duration":"202.694228ms","start":"2026-04-07T09:44:55.553431Z","end":"2026-04-07T09:44:55.756125Z","steps":["trace[867798263] 'process raft request' (duration: 202.540234ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:55.87714Z","caller":"traceutil/trace.go:171","msg":"trace[958670737] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1563; }","duration":"100.626276ms","start":"2026-04-07T09:44:55.776463Z","end":"2026-04-07T09:44:55.87709Z","steps":["trace[958670737] 'process raft request' (duration: 100.408001ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.097114Z","caller":"traceutil/trace.go:171","msg":"trace[1536077643] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1564; }","duration":"199.858049ms","start":"2026-04-07T09:44:55.89722Z","end":"2026-04-07T09:44:56.097078Z","steps":["trace[1536077643] 'process raft request' (duration: 126.860086ms)","trace[1536077643] 'compare' (duration: 72.894091ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.56266Z","caller":"traceutil/trace.go:171","msg":"trace[1554237857] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1565; }","duration":"443.108191ms","start":"2026-04-07T09:44:56.119513Z","end":"2026-04-07T09:44:56.562621Z","steps":["trace[1554237857] 'process raft request' (duration: 442.983578ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.562861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.119483Z","time spent":"443.280315ms","remote":"127.0.0.1:37472","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:44:56.633556Z","caller":"traceutil/trace.go:171","msg":"trace[659931834] transaction","detail":"{read_only:false; response_revision:1566; number_of_response:1; }","duration":"440.597901ms","start":"2026-04-07T09:44:56.192929Z","end":"2026-04-07T09:44:56.633526Z","steps":["trace[659931834] 'process raft request' (duration: 440.372975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.633741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:44:56.1929Z","time spent":"440.752225ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:44:56.633754Z","caller":"traceutil/trace.go:171","msg":"trace[161096398] linearizableReadLoop","detail":"{readStateIndex:1629; appliedIndex:1626; }","duration":"150.057743ms","start":"2026-04-07T09:44:56.483654Z","end":"2026-04-07T09:44:56.633711Z","steps":["trace[161096398] 'read index received' (duration: 78.774791ms)","trace[161096398] 'applied index is now lower than readState.Index' (duration: 71.279912ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:44:56.633856Z","caller":"traceutil/trace.go:171","msg":"trace[503020381] transaction","detail":"{read_only:false; response_revision:1567; number_of_response:1; }","duration":"199.609114ms","start":"2026-04-07T09:44:56.434205Z","end":"2026-04-07T09:44:56.633814Z","steps":["trace[503020381] 'process raft request' (duration: 199.276256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.633981Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.295809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:44:56.634033Z","caller":"traceutil/trace.go:171","msg":"trace[1970975588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1567; }","duration":"150.412153ms","start":"2026-04-07T09:44:56.483606Z","end":"2026-04-07T09:44:56.634018Z","steps":["trace[1970975588] 'agreement among raft nodes before linearized reading' (duration: 150.159327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.634053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.287859ms","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-04-07T09:44:56.634058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.381022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T09:44:56.634093Z","caller":"traceutil/trace.go:171","msg":"trace[414192135] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1567; }","duration":"150.366661ms","start":"2026-04-07T09:44:56.483713Z","end":"2026-04-07T09:44:56.63408Z","steps":["trace[414192135] 'agreement among raft nodes before linearized reading' (duration: 150.252878ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.634096Z","caller":"traceutil/trace.go:171","msg":"trace[1121325603] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1567; }","duration":"150.467533ms","start":"2026-04-07T09:44:56.483617Z","end":"2026-04-07T09:44:56.634084Z","steps":["trace[1121325603] 'agreement among raft nodes before linearized reading' (duration: 150.280249ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.634093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.946861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T09:44:56.634183Z","caller":"traceutil/trace.go:171","msg":"trace[723589585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1567; }","duration":"150.048263ms","start":"2026-04-07T09:44:56.484115Z","end":"2026-04-07T09:44:56.634164Z","steps":["trace[723589585] 'agreement among raft nodes before linearized reading' (duration: 149.879109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:44:56.633953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.289699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T09:44:56.63435Z","caller":"traceutil/trace.go:171","msg":"trace[633146729] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1567; }","duration":"150.721599ms","start":"2026-04-07T09:44:56.483617Z","end":"2026-04-07T09:44:56.634338Z","steps":["trace[633146729] 'agreement among raft nodes before linearized reading' (duration: 150.177036ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.798638Z","caller":"traceutil/trace.go:171","msg":"trace[1113867963] transaction","detail":"{read_only:false; response_revision:1571; number_of_response:1; }","duration":"158.779183ms","start":"2026-04-07T09:44:56.639822Z","end":"2026-04-07T09:44:56.798601Z","steps":["trace[1113867963] 'process raft request' (duration: 158.514706ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.798759Z","caller":"traceutil/trace.go:171","msg":"trace[1987722177] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1572; }","duration":"147.833ms","start":"2026-04-07T09:44:56.650892Z","end":"2026-04-07T09:44:56.798725Z","steps":["trace[1987722177] 'process raft request' (duration: 147.528633ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.798766Z","caller":"traceutil/trace.go:171","msg":"trace[1405622160] transaction","detail":"{read_only:false; response_revision:1572; number_of_response:1; }","duration":"158.200019ms","start":"2026-04-07T09:44:56.640535Z","end":"2026-04-07T09:44:56.798735Z","steps":["trace[1405622160] 'process raft request' (duration: 157.846781ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:56.79878Z","caller":"traceutil/trace.go:171","msg":"trace[2027618842] transaction","detail":"{read_only:false; response_revision:1570; number_of_response:1; }","duration":"159.006159ms","start":"2026-04-07T09:44:56.63975Z","end":"2026-04-07T09:44:56.798756Z","steps":["trace[2027618842] 'process raft request' (duration: 136.97596ms)","trace[2027618842] 'compare' (duration: 21.456695ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:45:15.403736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.745051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T09:45:15.403846Z","caller":"traceutil/trace.go:171","msg":"trace[836382580] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1871; }","duration":"327.895214ms","start":"2026-04-07T09:45:15.075925Z","end":"2026-04-07T09:45:15.40382Z","steps":["trace[836382580] 'range keys from in-memory index tree' (duration: 327.565516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:15.403891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:15.075908Z","time spent":"327.974106ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-07T09:45:15.404066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.07405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b46bb91-b654-4e31-87fb-caf1a8ce8293\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-07T09:45:15.404168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.635772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T09:45:15.404213Z","caller":"traceutil/trace.go:171","msg":"trace[1737527221] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6b46bb91-b654-4e31-87fb-caf1a8ce8293; range_end:; response_count:1; response_revision:1871; }","duration":"358.274013ms","start":"2026-04-07T09:45:15.045902Z","end":"2026-04-07T09:45:15.404176Z","steps":["trace[1737527221] 'range keys from in-memory index tree' (duration: 357.848003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:15.404224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.45957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b46bb91-b654-4e31-87fb-caf1a8ce8293\" ","response":"range_response_count:1 size:3627"} {"level":"warn","ts":"2026-04-07T09:45:15.404279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:15.045881Z","time spent":"358.385507ms","remote":"127.0.0.1:37598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-6b46bb91-b654-4e31-87fb-caf1a8ce8293\" "} {"level":"info","ts":"2026-04-07T09:45:15.40428Z","caller":"traceutil/trace.go:171","msg":"trace[1863983774] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:1871; }","duration":"104.784726ms","start":"2026-04-07T09:45:15.299468Z","end":"2026-04-07T09:45:15.404253Z","steps":["trace[1863983774] 'range keys from in-memory index tree' (duration: 104.388867ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:15.404336Z","caller":"traceutil/trace.go:171","msg":"trace[2069915104] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-6b46bb91-b654-4e31-87fb-caf1a8ce8293; range_end:; response_count:1; response_revision:1871; }","duration":"117.628475ms","start":"2026-04-07T09:45:15.286678Z","end":"2026-04-07T09:45:15.404306Z","steps":["trace[2069915104] 'range keys from in-memory index tree' (duration: 117.224895ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:15.570796Z","caller":"traceutil/trace.go:171","msg":"trace[348510540] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"157.736368ms","start":"2026-04-07T09:45:15.413033Z","end":"2026-04-07T09:45:15.57077Z","steps":["trace[348510540] 'process raft request' (duration: 157.665296ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:15.570782Z","caller":"traceutil/trace.go:171","msg":"trace[369662974] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"163.605008ms","start":"2026-04-07T09:45:15.407093Z","end":"2026-04-07T09:45:15.570698Z","steps":["trace[369662974] 'process raft request' (duration: 154.063529ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:15.57131Z","caller":"traceutil/trace.go:171","msg":"trace[1155045597] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"162.597095ms","start":"2026-04-07T09:45:15.408671Z","end":"2026-04-07T09:45:15.571268Z","steps":["trace[1155045597] 'process raft request' (duration: 161.944879ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:15.592881Z","caller":"traceutil/trace.go:171","msg":"trace[838759096] transaction","detail":"{read_only:false; response_revision:1875; number_of_response:1; }","duration":"144.536421ms","start":"2026-04-07T09:45:15.448271Z","end":"2026-04-07T09:45:15.592808Z","steps":["trace[838759096] 'process raft request' (duration: 144.264435ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:29.68647Z","caller":"traceutil/trace.go:171","msg":"trace[872143299] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"165.074443ms","start":"2026-04-07T09:45:29.521299Z","end":"2026-04-07T09:45:29.686373Z","steps":["trace[872143299] 'process raft request' (duration: 164.851048ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:59.188017Z","caller":"traceutil/trace.go:171","msg":"trace[725265337] transaction","detail":"{read_only:false; response_revision:2164; number_of_response:1; }","duration":"230.042265ms","start":"2026-04-07T09:45:58.957949Z","end":"2026-04-07T09:45:59.187991Z","steps":["trace[725265337] 'process raft request' (duration: 229.880061ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.531565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.301085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:45:59.53167Z","caller":"traceutil/trace.go:171","msg":"trace[321509396] linearizableReadLoop","detail":"{readStateIndex:2250; appliedIndex:2248; }","duration":"517.604757ms","start":"2026-04-07T09:45:59.01405Z","end":"2026-04-07T09:45:59.531654Z","steps":["trace[321509396] 'read index received' (duration: 173.784742ms)","trace[321509396] 'applied index is now lower than readState.Index' (duration: 343.818745ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:59.531732Z","caller":"traceutil/trace.go:171","msg":"trace[1204127719] transaction","detail":"{read_only:false; response_revision:2165; number_of_response:1; }","duration":"543.655928ms","start":"2026-04-07T09:45:58.988029Z","end":"2026-04-07T09:45:59.531685Z","steps":["trace[1204127719] 'process raft request' (duration: 374.139799ms)","trace[1204127719] 'compare' (duration: 169.015737ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:45:59.531848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.796061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-04-07T09:45:59.531888Z","caller":"traceutil/trace.go:171","msg":"trace[1869412897] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2165; }","duration":"517.875813ms","start":"2026-04-07T09:45:59.014002Z","end":"2026-04-07T09:45:59.531878Z","steps":["trace[1869412897] 'agreement among raft nodes before linearized reading' (duration: 517.726519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.531921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.013977Z","time spent":"517.938485ms","remote":"127.0.0.1:37598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12405,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-07T09:45:59.531943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.267281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-07T09:45:59.532004Z","caller":"traceutil/trace.go:171","msg":"trace[35476156] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2165; }","duration":"402.386284ms","start":"2026-04-07T09:45:59.129604Z","end":"2026-04-07T09:45:59.531991Z","steps":["trace[35476156] 'agreement among raft nodes before linearized reading' (duration: 402.184599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.532044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.129564Z","time spent":"402.465416ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T09:45:59.532036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.596071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-07T09:45:59.532081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.937708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:45:59.532144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"440.112535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T09:45:59.532224Z","caller":"traceutil/trace.go:171","msg":"trace[1276982902] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2165; }","duration":"440.205398ms","start":"2026-04-07T09:45:59.091993Z","end":"2026-04-07T09:45:59.532198Z","steps":["trace[1276982902] 'agreement among raft nodes before linearized reading' (duration: 439.973922ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:59.532234Z","caller":"traceutil/trace.go:171","msg":"trace[1248210926] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2165; }","duration":"447.168784ms","start":"2026-04-07T09:45:59.085013Z","end":"2026-04-07T09:45:59.532182Z","steps":["trace[1248210926] 'agreement among raft nodes before linearized reading' (duration: 446.922708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.532264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.13533ms","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-04-07T09:45:59.532243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.20999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-07T09:45:59.532303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.084979Z","time spent":"447.314277ms","remote":"127.0.0.1:37408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:45:59.531927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:58.987995Z","time spent":"543.830272ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:45:59.532359Z","caller":"traceutil/trace.go:171","msg":"trace[259310440] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2165; }","duration":"402.371914ms","start":"2026-04-07T09:45:59.129955Z","end":"2026-04-07T09:45:59.532327Z","steps":["trace[259310440] 'agreement among raft nodes before linearized reading' (duration: 402.040586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.532273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.091982Z","time spent":"440.277759ms","remote":"127.0.0.1:36006","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-07T09:45:59.532418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.12992Z","time spent":"402.488857ms","remote":"127.0.0.1:37670","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-04-07T09:45:59.532473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.524547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-07T09:45:59.532554Z","caller":"traceutil/trace.go:171","msg":"trace[53833180] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2165; }","duration":"513.220922ms","start":"2026-04-07T09:45:59.019074Z","end":"2026-04-07T09:45:59.532295Z","steps":["trace[53833180] 'agreement among raft nodes before linearized reading' (duration: 513.114779ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:59.532608Z","caller":"traceutil/trace.go:171","msg":"trace[1838249207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2165; }","duration":"402.736692ms","start":"2026-04-07T09:45:59.129845Z","end":"2026-04-07T09:45:59.532581Z","steps":["trace[1838249207] 'agreement among raft nodes before linearized reading' (duration: 402.282791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.532686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.018867Z","time spent":"513.800356ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-07T09:45:59.532695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.129817Z","time spent":"402.864055ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T09:45:59.532155Z","caller":"traceutil/trace.go:171","msg":"trace[568344470] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2165; }","duration":"513.785915ms","start":"2026-04-07T09:45:59.018339Z","end":"2026-04-07T09:45:59.532125Z","steps":["trace[568344470] 'agreement among raft nodes before linearized reading' (duration: 513.455417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.533796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:45:59.018306Z","time spent":"515.474325ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T09:45:59.789111Z","caller":"traceutil/trace.go:171","msg":"trace[1732786485] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"249.42649ms","start":"2026-04-07T09:45:59.53964Z","end":"2026-04-07T09:45:59.789066Z","steps":["trace[1732786485] 'process raft request' (duration: 249.331307ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:59.789188Z","caller":"traceutil/trace.go:171","msg":"trace[1257827511] transaction","detail":"{read_only:false; response_revision:2167; number_of_response:1; }","duration":"250.789672ms","start":"2026-04-07T09:45:59.538349Z","end":"2026-04-07T09:45:59.789138Z","steps":["trace[1257827511] 'process raft request' (duration: 250.477915ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:59.789322Z","caller":"traceutil/trace.go:171","msg":"trace[827671129] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"249.584403ms","start":"2026-04-07T09:45:59.539723Z","end":"2026-04-07T09:45:59.789308Z","steps":["trace[827671129] 'process raft request' (duration: 249.272666ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:45:59.789509Z","caller":"traceutil/trace.go:171","msg":"trace[73946574] linearizableReadLoop","detail":"{readStateIndex:2255; appliedIndex:2250; }","duration":"233.769105ms","start":"2026-04-07T09:45:59.555721Z","end":"2026-04-07T09:45:59.78949Z","steps":["trace[73946574] 'read index received' (duration: 39.387881ms)","trace[73946574] 'applied index is now lower than readState.Index' (duration: 194.380034ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:45:59.789618Z","caller":"traceutil/trace.go:171","msg":"trace[1548632621] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"249.077531ms","start":"2026-04-07T09:45:59.540502Z","end":"2026-04-07T09:45:59.789579Z","steps":["trace[1548632621] 'process raft request' (duration: 248.740043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:45:59.7897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.97081ms","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-04-07T09:45:59.789734Z","caller":"traceutil/trace.go:171","msg":"trace[1813184718] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2170; }","duration":"234.055592ms","start":"2026-04-07T09:45:59.555668Z","end":"2026-04-07T09:45:59.789724Z","steps":["trace[1813184718] 'agreement among raft nodes before linearized reading' (duration: 233.883138ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:00.080661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.113412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:46:00.080787Z","caller":"traceutil/trace.go:171","msg":"trace[763903415] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"221.865651ms","start":"2026-04-07T09:45:59.858902Z","end":"2026-04-07T09:46:00.080767Z","steps":["trace[763903415] 'process raft request' (duration: 49.556004ms)","trace[763903415] 'compare' (duration: 171.989969ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:05.541747Z","caller":"traceutil/trace.go:171","msg":"trace[16227265] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"184.800456ms","start":"2026-04-07T09:46:05.356915Z","end":"2026-04-07T09:46:05.541715Z","steps":["trace[16227265] 'process raft request' (duration: 97.92892ms)","trace[16227265] 'compare' (duration: 86.698372ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:05.758513Z","caller":"traceutil/trace.go:171","msg":"trace[620108325] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"134.693778ms","start":"2026-04-07T09:46:05.62377Z","end":"2026-04-07T09:46:05.758464Z","steps":["trace[620108325] 'process raft request' (duration: 68.337613ms)","trace[620108325] 'compare' (duration: 66.101119ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:05.974732Z","caller":"traceutil/trace.go:171","msg":"trace[266127325] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"154.061681ms","start":"2026-04-07T09:46:05.820637Z","end":"2026-04-07T09:46:05.974698Z","steps":["trace[266127325] 'process raft request' (duration: 102.149551ms)","trace[266127325] 'compare' (duration: 51.757076ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:05.986409Z","caller":"traceutil/trace.go:171","msg":"trace[1540113543] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"164.119411ms","start":"2026-04-07T09:46:05.822233Z","end":"2026-04-07T09:46:05.986352Z","steps":["trace[1540113543] 'process raft request' (duration: 163.698521ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:05.986647Z","caller":"traceutil/trace.go:171","msg":"trace[744816017] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"163.25664ms","start":"2026-04-07T09:46:05.823364Z","end":"2026-04-07T09:46:05.98662Z","steps":["trace[744816017] 'process raft request' (duration: 163.124807ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:05.986675Z","caller":"traceutil/trace.go:171","msg":"trace[964772886] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"163.939437ms","start":"2026-04-07T09:46:05.82269Z","end":"2026-04-07T09:46:05.986629Z","steps":["trace[964772886] 'process raft request' (duration: 163.611259ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:06.292388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.10947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-04-07T09:46:06.292515Z","caller":"traceutil/trace.go:171","msg":"trace[113232896] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2201; }","duration":"182.316935ms","start":"2026-04-07T09:46:06.110168Z","end":"2026-04-07T09:46:06.292485Z","steps":["trace[113232896] 'range keys from in-memory index tree' (duration: 181.699ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:07.206424Z","caller":"traceutil/trace.go:171","msg":"trace[1342518186] linearizableReadLoop","detail":"{readStateIndex:2293; appliedIndex:2292; }","duration":"121.489532ms","start":"2026-04-07T09:46:07.084913Z","end":"2026-04-07T09:46:07.206403Z","steps":["trace[1342518186] 'read index received' (duration: 121.234886ms)","trace[1342518186] 'applied index is now lower than readState.Index' (duration: 253.276µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:07.206471Z","caller":"traceutil/trace.go:171","msg":"trace[1286336985] transaction","detail":"{read_only:false; response_revision:2205; number_of_response:1; }","duration":"165.884153ms","start":"2026-04-07T09:46:07.040555Z","end":"2026-04-07T09:46:07.206439Z","steps":["trace[1286336985] 'process raft request' (duration: 165.671958ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:07.206543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.606215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:46:07.206574Z","caller":"traceutil/trace.go:171","msg":"trace[862151938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2205; }","duration":"121.684577ms","start":"2026-04-07T09:46:07.084879Z","end":"2026-04-07T09:46:07.206563Z","steps":["trace[862151938] 'agreement among raft nodes before linearized reading' (duration: 121.613876ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:07.738573Z","caller":"traceutil/trace.go:171","msg":"trace[1164967569] linearizableReadLoop","detail":"{readStateIndex:2294; appliedIndex:2293; }","duration":"392.478387ms","start":"2026-04-07T09:46:07.346064Z","end":"2026-04-07T09:46:07.738542Z","steps":["trace[1164967569] 'read index received' (duration: 392.17274ms)","trace[1164967569] 'applied index is now lower than readState.Index' (duration: 304.407µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:07.738711Z","caller":"traceutil/trace.go:171","msg":"trace[772625289] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"510.704332ms","start":"2026-04-07T09:46:07.227969Z","end":"2026-04-07T09:46:07.738674Z","steps":["trace[772625289] 'process raft request' (duration: 510.318092ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:07.738829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.733863ms","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":"warn","ts":"2026-04-07T09:46:07.738903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.094539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-07T09:46:07.738917Z","caller":"traceutil/trace.go:171","msg":"trace[530502149] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2206; }","duration":"392.897277ms","start":"2026-04-07T09:46:07.345998Z","end":"2026-04-07T09:46:07.738895Z","steps":["trace[530502149] 'agreement among raft nodes before linearized reading' (duration: 392.723913ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:46:07.738945Z","caller":"traceutil/trace.go:171","msg":"trace[780357152] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2206; }","duration":"143.189342ms","start":"2026-04-07T09:46:07.59574Z","end":"2026-04-07T09:46:07.738929Z","steps":["trace[780357152] 'agreement among raft nodes before linearized reading' (duration: 143.013587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:46:07.738982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:07.345961Z","time spent":"393.005269ms","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:46:07.739039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:46:07.227934Z","time spent":"510.944207ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:46:07.992051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.769221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:46:07.992179Z","caller":"traceutil/trace.go:171","msg":"trace[1742728297] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"199.363533ms","start":"2026-04-07T09:46:07.792798Z","end":"2026-04-07T09:46:07.992162Z","steps":["trace[1742728297] 'read index received' (duration: 20.323915ms)","trace[1742728297] 'applied index is now lower than readState.Index' (duration: 179.035867ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:46:07.992235Z","caller":"traceutil/trace.go:171","msg":"trace[2083018787] transaction","detail":"{read_only:false; response_revision:2207; number_of_response:1; }","duration":"225.6235ms","start":"2026-04-07T09:46:07.766575Z","end":"2026-04-07T09:46:07.992199Z","steps":["trace[2083018787] 'process raft request' (duration: 46.624554ms)","trace[2083018787] 'compare' (duration: 178.624478ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:46:07.992343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.508017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:46:07.992456Z","caller":"traceutil/trace.go:171","msg":"trace[1446937301] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2207; }","duration":"199.65419ms","start":"2026-04-07T09:46:07.792766Z","end":"2026-04-07T09:46:07.99242Z","steps":["trace[1446937301] 'agreement among raft nodes before linearized reading' (duration: 199.493076ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:47:39.767094Z","caller":"traceutil/trace.go:171","msg":"trace[743937060] transaction","detail":"{read_only:false; response_revision:2894; number_of_response:1; }","duration":"137.315974ms","start":"2026-04-07T09:47:39.629739Z","end":"2026-04-07T09:47:39.767055Z","steps":["trace[743937060] 'process raft request' (duration: 137.096998ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:50:25.596768Z","caller":"traceutil/trace.go:171","msg":"trace[80745961] linearizableReadLoop","detail":"{readStateIndex:4118; appliedIndex:4117; }","duration":"160.364153ms","start":"2026-04-07T09:50:25.436382Z","end":"2026-04-07T09:50:25.596746Z","steps":["trace[80745961] 'read index received' (duration: 160.305241ms)","trace[80745961] 'applied index is now lower than readState.Index' (duration: 57.942µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:50:25.596835Z","caller":"traceutil/trace.go:171","msg":"trace[1880658822] transaction","detail":"{read_only:false; response_revision:3964; number_of_response:1; }","duration":"160.870705ms","start":"2026-04-07T09:50:25.435934Z","end":"2026-04-07T09:50:25.596805Z","steps":["trace[1880658822] 'process raft request' (duration: 160.66468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:50:25.596984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.580228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T09:50:25.59703Z","caller":"traceutil/trace.go:171","msg":"trace[609343100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3964; }","duration":"160.640039ms","start":"2026-04-07T09:50:25.436378Z","end":"2026-04-07T09:50:25.597018Z","steps":["trace[609343100] 'agreement among raft nodes before linearized reading' (duration: 160.493456ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:50:25.79592Z","caller":"traceutil/trace.go:171","msg":"trace[959383697] transaction","detail":"{read_only:false; response_revision:3966; number_of_response:1; }","duration":"357.053176ms","start":"2026-04-07T09:50:25.438846Z","end":"2026-04-07T09:50:25.795899Z","steps":["trace[959383697] 'process raft request' (duration: 356.990995ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:50:25.796012Z","caller":"traceutil/trace.go:171","msg":"trace[576228955] transaction","detail":"{read_only:false; response_revision:3965; number_of_response:1; }","duration":"359.531706ms","start":"2026-04-07T09:50:25.436436Z","end":"2026-04-07T09:50:25.795968Z","steps":["trace[576228955] 'process raft request' (duration: 358.358868ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:50:25.796068Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:50:25.438838Z","time spent":"357.155018ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:50:25.796217Z","caller":"traceutil/trace.go:171","msg":"trace[867614037] transaction","detail":"{read_only:false; response_revision:3967; number_of_response:1; }","duration":"332.613531ms","start":"2026-04-07T09:50:25.463567Z","end":"2026-04-07T09:50:25.796181Z","steps":["trace[867614037] 'process raft request' (duration: 332.302663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:50:25.796235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:50:25.436428Z","time spent":"359.684789ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:50:25.796382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:50:25.463542Z","time spent":"332.758384ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:50:25.796495Z","caller":"traceutil/trace.go:171","msg":"trace[434351278] transaction","detail":"{read_only:false; response_revision:3968; number_of_response:1; }","duration":"229.302175ms","start":"2026-04-07T09:50:25.567181Z","end":"2026-04-07T09:50:25.796483Z","steps":["trace[434351278] 'process raft request' (duration: 228.888685ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:50:25.796565Z","caller":"traceutil/trace.go:171","msg":"trace[176923897] transaction","detail":"{read_only:false; response_revision:3969; number_of_response:1; }","duration":"195.672989ms","start":"2026-04-07T09:50:25.600875Z","end":"2026-04-07T09:50:25.796548Z","steps":["trace[176923897] 'process raft request' (duration: 195.511515ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:50:25.796577Z","caller":"traceutil/trace.go:171","msg":"trace[1894807620] linearizableReadLoop","detail":"{readStateIndex:4122; appliedIndex:4118; }","duration":"199.670655ms","start":"2026-04-07T09:50:25.596852Z","end":"2026-04-07T09:50:25.796523Z","steps":["trace[1894807620] 'read index received' (duration: 197.961744ms)","trace[1894807620] 'applied index is now lower than readState.Index' (duration: 1.707461ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:50:25.796637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.613544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:50:25.796751Z","caller":"traceutil/trace.go:171","msg":"trace[59389737] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:3969; }","duration":"348.754487ms","start":"2026-04-07T09:50:25.447978Z","end":"2026-04-07T09:50:25.796733Z","steps":["trace[59389737] 'agreement among raft nodes before linearized reading' (duration: 348.567253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:50:25.796758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.214108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T09:50:25.796793Z","caller":"traceutil/trace.go:171","msg":"trace[1468512086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3969; }","duration":"359.268759ms","start":"2026-04-07T09:50:25.437515Z","end":"2026-04-07T09:50:25.796784Z","steps":["trace[1468512086] 'agreement among raft nodes before linearized reading' (duration: 359.131076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:50:25.796794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:50:25.447967Z","time spent":"348.815649ms","remote":"127.0.0.1:59174","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:50:25.796823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:50:25.437456Z","time spent":"359.363031ms","remote":"127.0.0.1:37670","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-04-07T09:50:25.797039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.150895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret\" ","response":"range_response_count:1 size:692"} {"level":"info","ts":"2026-04-07T09:50:25.797096Z","caller":"traceutil/trace.go:171","msg":"trace[421545974] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-client-secret; range_end:; response_count:1; response_revision:3969; }","duration":"187.268337ms","start":"2026-04-07T09:50:25.609812Z","end":"2026-04-07T09:50:25.797081Z","steps":["trace[421545974] 'agreement among raft nodes before linearized reading' (duration: 186.97131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:46.285395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.519069ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:51:46.285605Z","caller":"traceutil/trace.go:171","msg":"trace[287567547] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"211.509668ms","start":"2026-04-07T09:51:46.074069Z","end":"2026-04-07T09:51:46.285579Z","steps":["trace[287567547] 'process raft request' (duration: 106.736272ms)","trace[287567547] 'compare' (duration: 104.351216ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:46.285723Z","caller":"traceutil/trace.go:171","msg":"trace[743312379] linearizableReadLoop","detail":"{readStateIndex:5028; appliedIndex:5027; }","duration":"151.39672ms","start":"2026-04-07T09:51:46.134282Z","end":"2026-04-07T09:51:46.285679Z","steps":["trace[743312379] 'read index received' (duration: 46.721497ms)","trace[743312379] 'applied index is now lower than readState.Index' (duration: 104.670773ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:46.285892Z","caller":"traceutil/trace.go:171","msg":"trace[2088297707] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"141.542964ms","start":"2026-04-07T09:51:46.144334Z","end":"2026-04-07T09:51:46.285877Z","steps":["trace[2088297707] 'process raft request' (duration: 141.431261ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:46.286037Z","caller":"traceutil/trace.go:171","msg":"trace[528702637] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"142.898596ms","start":"2026-04-07T09:51:46.143073Z","end":"2026-04-07T09:51:46.285971Z","steps":["trace[528702637] 'process raft request' (duration: 142.521077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:46.286102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.796869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-07T09:51:46.286264Z","caller":"traceutil/trace.go:171","msg":"trace[1110810905] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4839; }","duration":"152.148388ms","start":"2026-04-07T09:51:46.13409Z","end":"2026-04-07T09:51:46.286238Z","steps":["trace[1110810905] 'agreement among raft nodes before linearized reading' (duration: 151.765648ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:46.294496Z","caller":"traceutil/trace.go:171","msg":"trace[768557031] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"102.43134ms","start":"2026-04-07T09:51:46.192051Z","end":"2026-04-07T09:51:46.294482Z","steps":["trace[768557031] 'process raft request' (duration: 102.194114ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:46.295025Z","caller":"traceutil/trace.go:171","msg":"trace[496135256] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"101.98484ms","start":"2026-04-07T09:51:46.19303Z","end":"2026-04-07T09:51:46.295015Z","steps":["trace[496135256] 'process raft request' (duration: 101.268833ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:46.295175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.61313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-07T09:51:46.295267Z","caller":"traceutil/trace.go:171","msg":"trace[1086907711] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4841; }","duration":"160.776544ms","start":"2026-04-07T09:51:46.134468Z","end":"2026-04-07T09:51:46.295245Z","steps":["trace[1086907711] 'agreement among raft nodes before linearized reading' (duration: 160.527378ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:54.221157Z","caller":"traceutil/trace.go:171","msg":"trace[1588981706] transaction","detail":"{read_only:false; response_revision:5046; number_of_response:1; }","duration":"225.666882ms","start":"2026-04-07T09:51:53.995452Z","end":"2026-04-07T09:51:54.221119Z","steps":["trace[1588981706] 'process raft request' (duration: 144.104667ms)","trace[1588981706] 'compare' (duration: 81.36546ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:54.302596Z","caller":"traceutil/trace.go:171","msg":"trace[1248401680] linearizableReadLoop","detail":"{readStateIndex:5244; appliedIndex:5241; }","duration":"302.969996ms","start":"2026-04-07T09:51:53.999596Z","end":"2026-04-07T09:51:54.302566Z","steps":["trace[1248401680] 'read index received' (duration: 139.929007ms)","trace[1248401680] 'applied index is now lower than readState.Index' (duration: 163.040259ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:54.302761Z","caller":"traceutil/trace.go:171","msg":"trace[1929645422] transaction","detail":"{read_only:false; response_revision:5047; number_of_response:1; }","duration":"306.701795ms","start":"2026-04-07T09:51:53.996004Z","end":"2026-04-07T09:51:54.302706Z","steps":["trace[1929645422] 'process raft request' (duration: 306.332406ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:54.302705Z","caller":"traceutil/trace.go:171","msg":"trace[1260189521] transaction","detail":"{read_only:false; response_revision:5048; number_of_response:1; }","duration":"305.051495ms","start":"2026-04-07T09:51:53.997607Z","end":"2026-04-07T09:51:54.302658Z","steps":["trace[1260189521] 'process raft request' (duration: 304.895021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:54.302902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.268163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-07T09:51:54.302953Z","caller":"traceutil/trace.go:171","msg":"trace[1920519251] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5048; }","duration":"303.379495ms","start":"2026-04-07T09:51:53.999555Z","end":"2026-04-07T09:51:54.302935Z","steps":["trace[1920519251] 'agreement among raft nodes before linearized reading' (duration: 303.181661ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:54.302947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.936612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T09:51:54.302989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:51:53.999534Z","time spent":"303.447947ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":1,"response size":1364,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" "} {"level":"warn","ts":"2026-04-07T09:51:54.302965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:51:53.995974Z","time spent":"306.88394ms","remote":"127.0.0.1:37574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1250,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:51:54.30303Z","caller":"traceutil/trace.go:171","msg":"trace[1717282658] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5048; }","duration":"219.075785ms","start":"2026-04-07T09:51:54.083935Z","end":"2026-04-07T09:51:54.303011Z","steps":["trace[1717282658] 'agreement among raft nodes before linearized reading' (duration: 218.83907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:54.303035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:51:53.997582Z","time spent":"305.350352ms","remote":"127.0.0.1:37872","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4883,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:51:54.803014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.711033ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:51:54.803299Z","caller":"traceutil/trace.go:171","msg":"trace[1079720168] transaction","detail":"{read_only:false; response_revision:5077; number_of_response:1; }","duration":"116.300074ms","start":"2026-04-07T09:51:54.686979Z","end":"2026-04-07T09:51:54.803279Z","steps":["trace[1079720168] 'process raft request' (duration: 116.269683ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:54.803337Z","caller":"traceutil/trace.go:171","msg":"trace[1954704672] transaction","detail":"{read_only:false; response_revision:5073; number_of_response:1; }","duration":"120.019112ms","start":"2026-04-07T09:51:54.683269Z","end":"2026-04-07T09:51:54.803289Z","steps":["trace[1954704672] 'process raft request' (duration: 10.935071ms)","trace[1954704672] 'compare' (duration: 108.60699ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:54.80339Z","caller":"traceutil/trace.go:171","msg":"trace[497842869] transaction","detail":"{read_only:false; response_revision:5075; number_of_response:1; }","duration":"116.97273ms","start":"2026-04-07T09:51:54.686366Z","end":"2026-04-07T09:51:54.803338Z","steps":["trace[497842869] 'process raft request' (duration: 116.814546ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:54.803271Z","caller":"traceutil/trace.go:171","msg":"trace[424225492] linearizableReadLoop","detail":"{readStateIndex:5270; appliedIndex:5269; }","duration":"117.316927ms","start":"2026-04-07T09:51:54.685893Z","end":"2026-04-07T09:51:54.80321Z","steps":["trace[424225492] 'read index received' (duration: 8.336318ms)","trace[424225492] 'applied index is now lower than readState.Index' (duration: 108.971989ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:54.803437Z","caller":"traceutil/trace.go:171","msg":"trace[26767664] transaction","detail":"{read_only:false; response_revision:5076; number_of_response:1; }","duration":"116.822106ms","start":"2026-04-07T09:51:54.68657Z","end":"2026-04-07T09:51:54.803392Z","steps":["trace[26767664] 'process raft request' (duration: 116.640441ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:51:54.803598Z","caller":"traceutil/trace.go:171","msg":"trace[1103277764] transaction","detail":"{read_only:false; response_revision:5074; number_of_response:1; }","duration":"117.273777ms","start":"2026-04-07T09:51:54.686306Z","end":"2026-04-07T09:51:54.80358Z","steps":["trace[1103277764] 'process raft request' (duration: 116.814796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:54.803643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.717288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:119587"} {"level":"info","ts":"2026-04-07T09:51:54.803713Z","caller":"traceutil/trace.go:171","msg":"trace[385250905] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5077; }","duration":"117.8387ms","start":"2026-04-07T09:51:54.685862Z","end":"2026-04-07T09:51:54.8037Z","steps":["trace[385250905] 'agreement among raft nodes before linearized reading' (duration: 117.479242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:51:57.456732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.63168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:51:57.456843Z","caller":"traceutil/trace.go:171","msg":"trace[776653918] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"199.528189ms","start":"2026-04-07T09:51:57.257298Z","end":"2026-04-07T09:51:57.456826Z","steps":["trace[776653918] 'process raft request' (duration: 98.753715ms)","trace[776653918] 'compare' (duration: 100.446546ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:57.677236Z","caller":"traceutil/trace.go:171","msg":"trace[100106497] linearizableReadLoop","detail":"{readStateIndex:5383; appliedIndex:5382; }","duration":"188.318032ms","start":"2026-04-07T09:51:57.488889Z","end":"2026-04-07T09:51:57.677207Z","steps":["trace[100106497] 'read index received' (duration: 133.134066ms)","trace[100106497] 'applied index is now lower than readState.Index' (duration: 55.183106ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:51:57.677342Z","caller":"traceutil/trace.go:171","msg":"trace[2118527760] transaction","detail":"{read_only:false; response_revision:5183; number_of_response:1; }","duration":"215.848677ms","start":"2026-04-07T09:51:57.461435Z","end":"2026-04-07T09:51:57.677283Z","steps":["trace[2118527760] 'process raft request' (duration: 160.730443ms)","trace[2118527760] 'compare' (duration: 54.901629ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:51:57.677476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.574537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-aeda2661-5fb4-4e92-b13c-e64c39af4a9f\" ","response":"range_response_count:1 size:3601"} {"level":"info","ts":"2026-04-07T09:51:57.677511Z","caller":"traceutil/trace.go:171","msg":"trace[2064674068] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-aeda2661-5fb4-4e92-b13c-e64c39af4a9f; range_end:; response_count:1; response_revision:5183; }","duration":"188.634579ms","start":"2026-04-07T09:51:57.488868Z","end":"2026-04-07T09:51:57.677502Z","steps":["trace[2064674068] 'agreement among raft nodes before linearized reading' (duration: 188.442364ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:08.819443Z","caller":"traceutil/trace.go:171","msg":"trace[1530777066] transaction","detail":"{read_only:false; response_revision:5405; number_of_response:1; }","duration":"162.591368ms","start":"2026-04-07T09:52:08.656799Z","end":"2026-04-07T09:52:08.81939Z","steps":["trace[1530777066] 'process raft request' (duration: 162.220449ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:08.819495Z","caller":"traceutil/trace.go:171","msg":"trace[1469914245] transaction","detail":"{read_only:false; response_revision:5406; number_of_response:1; }","duration":"162.224848ms","start":"2026-04-07T09:52:08.657232Z","end":"2026-04-07T09:52:08.819456Z","steps":["trace[1469914245] 'process raft request' (duration: 162.058504ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:08.819685Z","caller":"traceutil/trace.go:171","msg":"trace[902119728] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"160.892256ms","start":"2026-04-07T09:52:08.658775Z","end":"2026-04-07T09:52:08.819667Z","steps":["trace[902119728] 'process raft request' (duration: 160.593479ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:08.819816Z","caller":"traceutil/trace.go:171","msg":"trace[491881286] linearizableReadLoop","detail":"{readStateIndex:5615; appliedIndex:5611; }","duration":"148.752118ms","start":"2026-04-07T09:52:08.671056Z","end":"2026-04-07T09:52:08.819808Z","steps":["trace[491881286] 'read index received' (duration: 147.941238ms)","trace[491881286] 'applied index is now lower than readState.Index' (duration: 810.36µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:52:08.819948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.14545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-07T09:52:08.819954Z","caller":"traceutil/trace.go:171","msg":"trace[2056300930] transaction","detail":"{read_only:false; response_revision:5408; number_of_response:1; }","duration":"161.04127ms","start":"2026-04-07T09:52:08.658861Z","end":"2026-04-07T09:52:08.819902Z","steps":["trace[2056300930] 'process raft request' (duration: 160.732363ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:08.819989Z","caller":"traceutil/trace.go:171","msg":"trace[1218602252] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5408; }","duration":"181.217012ms","start":"2026-04-07T09:52:08.63876Z","end":"2026-04-07T09:52:08.819977Z","steps":["trace[1218602252] 'agreement among raft nodes before linearized reading' (duration: 181.079419ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:08.879096Z","caller":"traceutil/trace.go:171","msg":"trace[1048582333] transaction","detail":"{read_only:false; response_revision:5409; number_of_response:1; }","duration":"203.313289ms","start":"2026-04-07T09:52:08.675744Z","end":"2026-04-07T09:52:08.879057Z","steps":["trace[1048582333] 'process raft request' (duration: 203.122454ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:08.99948Z","caller":"traceutil/trace.go:171","msg":"trace[232239870] transaction","detail":"{read_only:false; response_revision:5410; number_of_response:1; }","duration":"173.609061ms","start":"2026-04-07T09:52:08.825824Z","end":"2026-04-07T09:52:08.999433Z","steps":["trace[232239870] 'process raft request' (duration: 138.74642ms)","trace[232239870] 'compare' (duration: 34.361379ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:52:16.765566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.195835ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:52:16.765723Z","caller":"traceutil/trace.go:171","msg":"trace[1712132710] linearizableReadLoop","detail":"{readStateIndex:5769; appliedIndex:5768; }","duration":"231.680126ms","start":"2026-04-07T09:52:16.534021Z","end":"2026-04-07T09:52:16.765701Z","steps":["trace[1712132710] 'read index received' (duration: 127.194194ms)","trace[1712132710] 'applied index is now lower than readState.Index' (duration: 104.484362ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:52:16.76574Z","caller":"traceutil/trace.go:171","msg":"trace[2094218900] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"240.270291ms","start":"2026-04-07T09:52:16.525436Z","end":"2026-04-07T09:52:16.765706Z","steps":["trace[2094218900] 'process raft request' (duration: 135.814579ms)","trace[2094218900] 'compare' (duration: 103.797296ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:52:16.766042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.810169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-07T09:52:16.766085Z","caller":"traceutil/trace.go:171","msg":"trace[1637093035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5559; }","duration":"130.910282ms","start":"2026-04-07T09:52:16.635164Z","end":"2026-04-07T09:52:16.766075Z","steps":["trace[1637093035] 'agreement among raft nodes before linearized reading' (duration: 130.672657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:16.76622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.108685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-04-07T09:52:16.766435Z","caller":"traceutil/trace.go:171","msg":"trace[554455712] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:5559; }","duration":"232.402782ms","start":"2026-04-07T09:52:16.53396Z","end":"2026-04-07T09:52:16.766363Z","steps":["trace[554455712] 'agreement among raft nodes before linearized reading' (duration: 231.86497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:16.766483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.890806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T09:52:16.766554Z","caller":"traceutil/trace.go:171","msg":"trace[1061790906] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5559; }","duration":"113.963128ms","start":"2026-04-07T09:52:16.652574Z","end":"2026-04-07T09:52:16.766537Z","steps":["trace[1061790906] 'agreement among raft nodes before linearized reading' (duration: 113.773053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:17.096131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.58017ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:52:17.096231Z","caller":"traceutil/trace.go:171","msg":"trace[805518542] linearizableReadLoop","detail":"{readStateIndex:5782; appliedIndex:5781; }","duration":"282.808995ms","start":"2026-04-07T09:52:16.813406Z","end":"2026-04-07T09:52:17.096215Z","steps":["trace[805518542] 'read index received' (duration: 153.079341ms)","trace[805518542] 'applied index is now lower than readState.Index' (duration: 129.728194ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:52:17.096304Z","caller":"traceutil/trace.go:171","msg":"trace[543801554] transaction","detail":"{read_only:false; response_revision:5572; number_of_response:1; }","duration":"286.201726ms","start":"2026-04-07T09:52:16.810093Z","end":"2026-04-07T09:52:17.096295Z","steps":["trace[543801554] 'process raft request' (duration: 156.39138ms)","trace[543801554] 'compare' (duration: 129.206222ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:52:17.096644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.207495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-07T09:52:17.096746Z","caller":"traceutil/trace.go:171","msg":"trace[2009678543] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:5572; }","duration":"283.348437ms","start":"2026-04-07T09:52:16.813375Z","end":"2026-04-07T09:52:17.096723Z","steps":["trace[2009678543] 'agreement among raft nodes before linearized reading' (duration: 282.933607ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:17.150844Z","caller":"traceutil/trace.go:171","msg":"trace[982669742] transaction","detail":"{read_only:false; response_revision:5573; number_of_response:1; }","duration":"337.370325ms","start":"2026-04-07T09:52:16.813415Z","end":"2026-04-07T09:52:17.150785Z","steps":["trace[982669742] 'process raft request' (duration: 337.059488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:17.150963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.755917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-07T09:52:17.151034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.729506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-07T09:52:17.151083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:52:16.813406Z","time spent":"337.55056ms","remote":"127.0.0.1:37494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":902,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:52:17.151132Z","caller":"traceutil/trace.go:171","msg":"trace[1358113633] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5574; }","duration":"109.88607ms","start":"2026-04-07T09:52:17.041226Z","end":"2026-04-07T09:52:17.151112Z","steps":["trace[1358113633] 'agreement among raft nodes before linearized reading' (duration: 109.576493ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:17.151065Z","caller":"traceutil/trace.go:171","msg":"trace[874017491] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5574; }","duration":"231.923631ms","start":"2026-04-07T09:52:16.91912Z","end":"2026-04-07T09:52:17.151044Z","steps":["trace[874017491] 'agreement among raft nodes before linearized reading' (duration: 231.703465ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:17.151205Z","caller":"traceutil/trace.go:171","msg":"trace[948766374] transaction","detail":"{read_only:false; response_revision:5574; number_of_response:1; }","duration":"328.74666ms","start":"2026-04-07T09:52:16.822387Z","end":"2026-04-07T09:52:17.151134Z","steps":["trace[948766374] 'process raft request' (duration: 328.263188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:17.151497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.267006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3565"} {"level":"info","ts":"2026-04-07T09:52:17.151623Z","caller":"traceutil/trace.go:171","msg":"trace[2075481519] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5574; }","duration":"317.445201ms","start":"2026-04-07T09:52:16.834156Z","end":"2026-04-07T09:52:17.151601Z","steps":["trace[2075481519] 'agreement among raft nodes before linearized reading' (duration: 316.849687ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:17.151665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:52:16.834143Z","time spent":"317.514562ms","remote":"127.0.0.1:37512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":3587,"request content":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" "} {"level":"warn","ts":"2026-04-07T09:52:17.151531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:52:16.822371Z","time spent":"328.992326ms","remote":"127.0.0.1:37892","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7067,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:52:17.426973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.960021ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:52:17.427225Z","caller":"traceutil/trace.go:171","msg":"trace[219604945] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"178.844395ms","start":"2026-04-07T09:52:17.248363Z","end":"2026-04-07T09:52:17.427208Z","steps":["trace[219604945] 'process raft request' (duration: 178.733332ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:17.427254Z","caller":"traceutil/trace.go:171","msg":"trace[1038960269] linearizableReadLoop","detail":"{readStateIndex:5786; appliedIndex:5785; }","duration":"247.861561ms","start":"2026-04-07T09:52:17.17935Z","end":"2026-04-07T09:52:17.427211Z","steps":["trace[1038960269] 'read index received' (duration: 49.46696ms)","trace[1038960269] 'applied index is now lower than readState.Index' (duration: 198.390861ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:52:17.427461Z","caller":"traceutil/trace.go:171","msg":"trace[322596480] transaction","detail":"{read_only:false; response_revision:5576; number_of_response:1; }","duration":"269.755454ms","start":"2026-04-07T09:52:17.157683Z","end":"2026-04-07T09:52:17.427438Z","steps":["trace[322596480] 'process raft request' (duration: 71.234979ms)","trace[322596480] 'compare' (duration: 197.651334ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:52:17.427699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.559879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:52:17.427966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.18224ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" ","response":"range_response_count:1 size:4867"} {"level":"info","ts":"2026-04-07T09:52:17.427986Z","caller":"traceutil/trace.go:171","msg":"trace[1208681973] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:0; response_revision:5577; }","duration":"269.916158ms","start":"2026-04-07T09:52:17.158045Z","end":"2026-04-07T09:52:17.427961Z","steps":["trace[1208681973] 'agreement among raft nodes before linearized reading' (duration: 269.536259ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:17.428043Z","caller":"traceutil/trace.go:171","msg":"trace[1928636842] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager; range_end:; response_count:1; response_revision:5577; }","duration":"264.316763ms","start":"2026-04-07T09:52:17.163707Z","end":"2026-04-07T09:52:17.428024Z","steps":["trace[1928636842] 'agreement among raft nodes before linearized reading' (duration: 263.878383ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:52:17.427973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.400889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-07T09:52:17.428109Z","caller":"traceutil/trace.go:171","msg":"trace[1388343857] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5577; }","duration":"244.572893ms","start":"2026-04-07T09:52:17.183519Z","end":"2026-04-07T09:52:17.428092Z","steps":["trace[1388343857] 'agreement among raft nodes before linearized reading' (duration: 244.096522ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:18.927044Z","caller":"traceutil/trace.go:171","msg":"trace[1424422510] transaction","detail":"{read_only:false; response_revision:5595; number_of_response:1; }","duration":"116.579721ms","start":"2026-04-07T09:52:18.810415Z","end":"2026-04-07T09:52:18.926995Z","steps":["trace[1424422510] 'process raft request' (duration: 91.599185ms)","trace[1424422510] 'compare' (duration: 24.781881ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:52:18.934643Z","caller":"traceutil/trace.go:171","msg":"trace[1305970581] transaction","detail":"{read_only:false; response_revision:5596; number_of_response:1; }","duration":"122.956173ms","start":"2026-04-07T09:52:18.811657Z","end":"2026-04-07T09:52:18.934614Z","steps":["trace[1305970581] 'process raft request' (duration: 122.750238ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:18.934811Z","caller":"traceutil/trace.go:171","msg":"trace[1192661213] transaction","detail":"{read_only:false; response_revision:5597; number_of_response:1; }","duration":"122.566243ms","start":"2026-04-07T09:52:18.812209Z","end":"2026-04-07T09:52:18.934776Z","steps":["trace[1192661213] 'process raft request' (duration: 122.353458ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:52:52.207033Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2962} {"level":"info","ts":"2026-04-07T09:52:52.281155Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2962,"took":"72.091939ms","hash":3009205163,"current-db-size-bytes":55910400,"current-db-size":"56 MB","current-db-size-in-use-bytes":31657984,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-07T09:52:52.281216Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3009205163,"revision":2962,"compact-revision":-1} {"level":"info","ts":"2026-04-07T09:53:08.868284Z","caller":"traceutil/trace.go:171","msg":"trace[1727645281] transaction","detail":"{read_only:false; response_revision:6077; number_of_response:1; }","duration":"121.370352ms","start":"2026-04-07T09:53:08.74688Z","end":"2026-04-07T09:53:08.86825Z","steps":["trace[1727645281] 'process raft request' (duration: 121.185218ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:53:08.896369Z","caller":"traceutil/trace.go:171","msg":"trace[1363895330] transaction","detail":"{read_only:false; response_revision:6078; number_of_response:1; }","duration":"101.204121ms","start":"2026-04-07T09:53:08.794679Z","end":"2026-04-07T09:53:08.895883Z","steps":["trace[1363895330] 'process raft request' (duration: 100.845143ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:53:09.158647Z","caller":"traceutil/trace.go:171","msg":"trace[1912706532] transaction","detail":"{read_only:false; response_revision:6079; number_of_response:1; }","duration":"142.69289ms","start":"2026-04-07T09:53:09.015916Z","end":"2026-04-07T09:53:09.158609Z","steps":["trace[1912706532] 'process raft request' (duration: 142.29471ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:57:52.213951Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5888} {"level":"info","ts":"2026-04-07T09:57:52.298253Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5888,"took":"82.234616ms","hash":2903803527,"current-db-size-bytes":55910400,"current-db-size":"56 MB","current-db-size-in-use-bytes":25571328,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-07T09:57:52.298329Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2903803527,"revision":5888,"compact-revision":2962} {"level":"info","ts":"2026-04-07T09:58:13.655977Z","caller":"traceutil/trace.go:171","msg":"trace[1737910711] linearizableReadLoop","detail":"{readStateIndex:8658; appliedIndex:8657; }","duration":"209.147844ms","start":"2026-04-07T09:58:13.446809Z","end":"2026-04-07T09:58:13.655956Z","steps":["trace[1737910711] 'read index received' (duration: 209.022661ms)","trace[1737910711] 'applied index is now lower than readState.Index' (duration: 124.303µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:13.65608Z","caller":"traceutil/trace.go:171","msg":"trace[237999005] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"261.211193ms","start":"2026-04-07T09:58:13.394849Z","end":"2026-04-07T09:58:13.65606Z","steps":["trace[237999005] 'process raft request' (duration: 260.965737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:13.656134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.305039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:58:13.65616Z","caller":"traceutil/trace.go:171","msg":"trace[1875016248] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:8361; }","duration":"209.395031ms","start":"2026-04-07T09:58:13.446757Z","end":"2026-04-07T09:58:13.656152Z","steps":["trace[1875016248] 'agreement among raft nodes before linearized reading' (duration: 209.292398ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:25.195674Z","caller":"traceutil/trace.go:171","msg":"trace[27349797] transaction","detail":"{read_only:false; response_revision:8418; number_of_response:1; }","duration":"132.055031ms","start":"2026-04-07T09:58:25.063593Z","end":"2026-04-07T09:58:25.195648Z","steps":["trace[27349797] 'process raft request' (duration: 131.871966ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:25.206725Z","caller":"traceutil/trace.go:171","msg":"trace[1671037231] linearizableReadLoop","detail":"{readStateIndex:8719; appliedIndex:8717; }","duration":"137.88548ms","start":"2026-04-07T09:58:25.068813Z","end":"2026-04-07T09:58:25.206699Z","steps":["trace[1671037231] 'read index received' (duration: 126.701343ms)","trace[1671037231] 'applied index is now lower than readState.Index' (duration: 11.183117ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:25.206878Z","caller":"traceutil/trace.go:171","msg":"trace[542666221] transaction","detail":"{read_only:false; response_revision:8419; number_of_response:1; }","duration":"140.920552ms","start":"2026-04-07T09:58:25.065886Z","end":"2026-04-07T09:58:25.206806Z","steps":["trace[542666221] 'process raft request' (duration: 140.661886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:25.207016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.176836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T09:58:25.207069Z","caller":"traceutil/trace.go:171","msg":"trace[1722800894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8419; }","duration":"138.267259ms","start":"2026-04-07T09:58:25.06879Z","end":"2026-04-07T09:58:25.207057Z","steps":["trace[1722800894] 'agreement among raft nodes before linearized reading' (duration: 138.089975ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:25.207078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.35192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:58:25.207171Z","caller":"traceutil/trace.go:171","msg":"trace[365548070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8419; }","duration":"122.476313ms","start":"2026-04-07T09:58:25.084674Z","end":"2026-04-07T09:58:25.20715Z","steps":["trace[365548070] 'agreement among raft nodes before linearized reading' (duration: 122.33216ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:25.487748Z","caller":"traceutil/trace.go:171","msg":"trace[138456600] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"276.082267ms","start":"2026-04-07T09:58:25.211641Z","end":"2026-04-07T09:58:25.487723Z","steps":["trace[138456600] 'process raft request' (duration: 275.661537ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:25.53217Z","caller":"traceutil/trace.go:171","msg":"trace[887134051] linearizableReadLoop","detail":"{readStateIndex:8721; appliedIndex:8719; }","duration":"189.406655ms","start":"2026-04-07T09:58:25.342737Z","end":"2026-04-07T09:58:25.532144Z","steps":["trace[887134051] 'read index received' (duration: 144.5974ms)","trace[887134051] 'applied index is now lower than readState.Index' (duration: 44.807965ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:25.532307Z","caller":"traceutil/trace.go:171","msg":"trace[1999848042] transaction","detail":"{read_only:false; response_revision:8421; number_of_response:1; }","duration":"320.585025ms","start":"2026-04-07T09:58:25.211664Z","end":"2026-04-07T09:58:25.532249Z","steps":["trace[1999848042] 'process raft request' (duration: 320.326569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:25.532509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.759603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.162\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-04-07T09:58:25.532534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:58:25.211638Z","time spent":"320.8067ms","remote":"127.0.0.1:37670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:58:25.532574Z","caller":"traceutil/trace.go:171","msg":"trace[968778388] range","detail":"{range_begin:/registry/masterleases/199.204.45.162; range_end:; response_count:1; response_revision:8421; }","duration":"189.874806ms","start":"2026-04-07T09:58:25.342681Z","end":"2026-04-07T09:58:25.532556Z","steps":["trace[968778388] 'agreement among raft nodes before linearized reading' (duration: 189.61585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:26.500848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.331651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:58:26.500928Z","caller":"traceutil/trace.go:171","msg":"trace[464365636] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:8425; }","duration":"117.475244ms","start":"2026-04-07T09:58:26.383437Z","end":"2026-04-07T09:58:26.500913Z","steps":["trace[464365636] 'count revisions from in-memory index tree' (duration: 117.229199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:27.195365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.877787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:58:27.195421Z","caller":"traceutil/trace.go:171","msg":"trace[181072290] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8428; }","duration":"110.982239ms","start":"2026-04-07T09:58:27.084425Z","end":"2026-04-07T09:58:27.195408Z","steps":["trace[181072290] 'range keys from in-memory index tree' (duration: 110.786156ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:27.434198Z","caller":"traceutil/trace.go:171","msg":"trace[1802244294] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"171.53417ms","start":"2026-04-07T09:58:27.262633Z","end":"2026-04-07T09:58:27.434167Z","steps":["trace[1802244294] 'process raft request' (duration: 171.306225ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:27.645899Z","caller":"traceutil/trace.go:171","msg":"trace[520148210] transaction","detail":"{read_only:false; response_revision:8433; number_of_response:1; }","duration":"105.110201ms","start":"2026-04-07T09:58:27.540756Z","end":"2026-04-07T09:58:27.645867Z","steps":["trace[520148210] 'process raft request' (duration: 87.02469ms)","trace[520148210] 'compare' (duration: 17.895166ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:58:28.027908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.22714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:58:28.028004Z","caller":"traceutil/trace.go:171","msg":"trace[1854277451] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:8434; }","duration":"112.379813ms","start":"2026-04-07T09:58:27.915604Z","end":"2026-04-07T09:58:28.027983Z","steps":["trace[1854277451] 'count revisions from in-memory index tree' (duration: 112.100356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:51.774983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.270415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T09:58:51.775047Z","caller":"traceutil/trace.go:171","msg":"trace[1990606396] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8612; }","duration":"108.366648ms","start":"2026-04-07T09:58:51.666667Z","end":"2026-04-07T09:58:51.775034Z","steps":["trace[1990606396] 'range keys from in-memory index tree' (duration: 108.197213ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:54.672699Z","caller":"traceutil/trace.go:171","msg":"trace[1412253409] linearizableReadLoop","detail":"{readStateIndex:8938; appliedIndex:8937; }","duration":"230.692887ms","start":"2026-04-07T09:58:54.441988Z","end":"2026-04-07T09:58:54.672681Z","steps":["trace[1412253409] 'read index received' (duration: 230.565164ms)","trace[1412253409] 'applied index is now lower than readState.Index' (duration: 127.203µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:58:54.672825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.8338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-lfh49\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-07T09:58:54.672847Z","caller":"traceutil/trace.go:171","msg":"trace[666688120] range","detail":"{range_begin:/registry/pods/openstack/keepalived-lfh49; range_end:; response_count:1; response_revision:8630; }","duration":"230.867602ms","start":"2026-04-07T09:58:54.441972Z","end":"2026-04-07T09:58:54.67284Z","steps":["trace[666688120] 'agreement among raft nodes before linearized reading' (duration: 230.772029ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:54.672802Z","caller":"traceutil/trace.go:171","msg":"trace[1198381529] transaction","detail":"{read_only:false; response_revision:8630; number_of_response:1; }","duration":"291.619077ms","start":"2026-04-07T09:58:54.381136Z","end":"2026-04-07T09:58:54.672755Z","steps":["trace[1198381529] 'process raft request' (duration: 291.453993ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:54.868079Z","caller":"traceutil/trace.go:171","msg":"trace[1447212839] transaction","detail":"{read_only:false; response_revision:8631; number_of_response:1; }","duration":"187.716335ms","start":"2026-04-07T09:58:54.68034Z","end":"2026-04-07T09:58:54.868056Z","steps":["trace[1447212839] 'process raft request' (duration: 186.987258ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:57.965771Z","caller":"traceutil/trace.go:171","msg":"trace[838260163] linearizableReadLoop","detail":"{readStateIndex:8958; appliedIndex:8957; }","duration":"157.943517ms","start":"2026-04-07T09:58:57.807806Z","end":"2026-04-07T09:58:57.96575Z","steps":["trace[838260163] 'read index received' (duration: 157.727432ms)","trace[838260163] 'applied index is now lower than readState.Index' (duration: 215.015µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:57.965873Z","caller":"traceutil/trace.go:171","msg":"trace[712526942] transaction","detail":"{read_only:false; response_revision:8649; number_of_response:1; }","duration":"158.463779ms","start":"2026-04-07T09:58:57.807375Z","end":"2026-04-07T09:58:57.965838Z","steps":["trace[712526942] 'process raft request' (duration: 158.236804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:58:57.965958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.129881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T09:58:57.966091Z","caller":"traceutil/trace.go:171","msg":"trace[707966401] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8649; }","duration":"158.310186ms","start":"2026-04-07T09:58:57.807764Z","end":"2026-04-07T09:58:57.966074Z","steps":["trace[707966401] 'agreement among raft nodes before linearized reading' (duration: 158.092591ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:58:58.129093Z","caller":"traceutil/trace.go:171","msg":"trace[471269185] transaction","detail":"{read_only:false; response_revision:8650; number_of_response:1; }","duration":"159.498014ms","start":"2026-04-07T09:58:57.969573Z","end":"2026-04-07T09:58:58.129071Z","steps":["trace[471269185] 'process raft request' (duration: 109.587477ms)","trace[471269185] 'compare' (duration: 49.756253ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:58:58.129241Z","caller":"traceutil/trace.go:171","msg":"trace[129369935] transaction","detail":"{read_only:false; response_revision:8651; number_of_response:1; }","duration":"159.028402ms","start":"2026-04-07T09:58:57.970195Z","end":"2026-04-07T09:58:58.129223Z","steps":["trace[129369935] 'process raft request' (duration: 158.839518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:59:07.669838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.228046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:59:07.669967Z","caller":"traceutil/trace.go:171","msg":"trace[682385739] transaction","detail":"{read_only:false; response_revision:8743; number_of_response:1; }","duration":"146.116995ms","start":"2026-04-07T09:59:07.523828Z","end":"2026-04-07T09:59:07.669945Z","steps":["trace[682385739] 'process raft request' (duration: 42.664034ms)","trace[682385739] 'compare' (duration: 103.074032ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:59:08.33474Z","caller":"traceutil/trace.go:171","msg":"trace[1245465596] linearizableReadLoop","detail":"{readStateIndex:9063; appliedIndex:9062; }","duration":"155.463668ms","start":"2026-04-07T09:59:08.179252Z","end":"2026-04-07T09:59:08.334715Z","steps":["trace[1245465596] 'read index received' (duration: 155.324044ms)","trace[1245465596] 'applied index is now lower than readState.Index' (duration: 138.694µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:59:08.334796Z","caller":"traceutil/trace.go:171","msg":"trace[1120692101] transaction","detail":"{read_only:false; response_revision:8749; number_of_response:1; }","duration":"156.948923ms","start":"2026-04-07T09:59:08.177817Z","end":"2026-04-07T09:59:08.334766Z","steps":["trace[1120692101] 'process raft request' (duration: 156.753088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:59:08.334958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.680273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-07T09:59:08.334998Z","caller":"traceutil/trace.go:171","msg":"trace[823706176] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8749; }","duration":"155.779295ms","start":"2026-04-07T09:59:08.179207Z","end":"2026-04-07T09:59:08.334986Z","steps":["trace[823706176] 'agreement among raft nodes before linearized reading' (duration: 155.624151ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:59:08.342363Z","caller":"traceutil/trace.go:171","msg":"trace[1493827526] transaction","detail":"{read_only:false; response_revision:8750; number_of_response:1; }","duration":"140.992923ms","start":"2026-04-07T09:59:08.201353Z","end":"2026-04-07T09:59:08.342346Z","steps":["trace[1493827526] 'process raft request' (duration: 140.710276ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:59:57.52652Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002523.wal"} {"level":"info","ts":"2026-04-07T10:00:56.340325Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"2d372260bb4c37a","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-07T10:00:56.348251Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-07T10:00:56.348369Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-04-07T10:01:27.169973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.751053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-07T10:01:27.17006Z","caller":"traceutil/trace.go:171","msg":"trace[1450616586] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:9819; }","duration":"184.901747ms","start":"2026-04-07T10:01:26.98514Z","end":"2026-04-07T10:01:27.170042Z","steps":["trace[1450616586] 'range keys from in-memory index tree' (duration: 184.544239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T10:01:27.1703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.837485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-07T10:01:27.17035Z","caller":"traceutil/trace.go:171","msg":"trace[1267197215] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:9819; }","duration":"153.016579ms","start":"2026-04-07T10:01:27.017322Z","end":"2026-04-07T10:01:27.170338Z","steps":["trace[1267197215] 'range keys from in-memory index tree' (duration: 152.325692ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T10:02:52.219661Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8067} {"level":"info","ts":"2026-04-07T10:02:52.282602Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8067,"took":"60.285702ms","hash":4144755205,"current-db-size-bytes":55910400,"current-db-size":"56 MB","current-db-size-in-use-bytes":28188672,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-07T10:02:52.282667Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4144755205,"revision":8067,"compact-revision":5888} {"level":"info","ts":"2026-04-07T10:04:37.543844Z","caller":"traceutil/trace.go:171","msg":"trace[435330322] transaction","detail":"{read_only:false; response_revision:11121; number_of_response:1; }","duration":"172.124852ms","start":"2026-04-07T10:04:37.371695Z","end":"2026-04-07T10:04:37.54382Z","steps":["trace[435330322] 'process raft request' (duration: 171.974598ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T10:07:52.226101Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10416} {"level":"info","ts":"2026-04-07T10:07:52.307073Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10416,"took":"78.525147ms","hash":347773473,"current-db-size-bytes":55910400,"current-db-size":"56 MB","current-db-size-in-use-bytes":22630400,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-07T10:07:52.307145Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":347773473,"revision":10416,"compact-revision":8067}