{"level":"warn","ts":"2026-09-18T15:17:41.631627Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T15:17:41.632045Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.59: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://162.253.55.59:2380","--initial-cluster=instance=https://162.253.55.59:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.59:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.59: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-09-18T15:17:41.632134Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-18T15:17:41.632144Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-09-18T15:17:41.632167Z","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-09-18T15:17:41.632909Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"]} {"level":"info","ts":"2026-09-18T15:17:41.632994Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.59: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-09-18T15:17:41.639529Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.302622ms"} {"level":"info","ts":"2026-09-18T15:17:41.64583Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f5132dc9ac390b66","cluster-id":"458d1cb56ab56fc4"} {"level":"info","ts":"2026-09-18T15:17:41.64598Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=()"} {"level":"info","ts":"2026-09-18T15:17:41.646012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 0"} {"level":"info","ts":"2026-09-18T15:17:41.64603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f5132dc9ac390b66 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-18T15:17:41.646052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became follower at term 1"} {"level":"info","ts":"2026-09-18T15:17:41.646109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"warn","ts":"2026-09-18T15:17:41.654375Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-18T15:17:41.656258Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-18T15:17:41.660134Z","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-09-18T15:17:41.664863Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f5132dc9ac390b66","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-18T15:17:41.66654Z","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-09-18T15:17:41.666675Z","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-09-18T15:17:41.666687Z","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-09-18T15:17:41.667075Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f5132dc9ac390b66","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-18T15:17:41.667896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 switched to configuration voters=(17659508908050942822)"} {"level":"info","ts":"2026-09-18T15:17:41.668062Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","added-peer-id":"f5132dc9ac390b66","added-peer-peer-urls":["https://162.253.55.59:2380"]} {"level":"info","ts":"2026-09-18T15:17:41.668425Z","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-09-18T15:17:41.668572Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-09-18T15:17:41.668641Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.59:2380"} {"level":"info","ts":"2026-09-18T15:17:41.669206Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f5132dc9ac390b66","initial-advertise-peer-urls":["https://162.253.55.59:2380"],"listen-peer-urls":["https://162.253.55.59:2380"],"advertise-client-urls":["https://162.253.55.59:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.59:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-18T15:17:41.669265Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-18T15:17:42.44682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 is starting a new election at term 1"} {"level":"info","ts":"2026-09-18T15:17:42.446881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-18T15:17:42.446915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgPreVoteResp from f5132dc9ac390b66 at term 1"} {"level":"info","ts":"2026-09-18T15:17:42.446928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became candidate at term 2"} {"level":"info","ts":"2026-09-18T15:17:42.446935Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 received MsgVoteResp from f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-09-18T15:17:42.446946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f5132dc9ac390b66 became leader at term 2"} {"level":"info","ts":"2026-09-18T15:17:42.446955Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f5132dc9ac390b66 elected leader f5132dc9ac390b66 at term 2"} {"level":"info","ts":"2026-09-18T15:17:42.452676Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:42.453641Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f5132dc9ac390b66","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.59:2379]}","request-path":"/0/members/f5132dc9ac390b66/attributes","cluster-id":"458d1cb56ab56fc4","publish-timeout":"7s"} {"level":"info","ts":"2026-09-18T15:17:42.453769Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:17:42.453728Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-18T15:17:42.453976Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-18T15:17:42.454051Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-18T15:17:42.455825Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"458d1cb56ab56fc4","local-member-id":"f5132dc9ac390b66","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:42.456075Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:42.456131Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-18T15:17:42.456521Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-18T15:17:42.458759Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.59:2379"} {"level":"info","ts":"2026-09-18T15:17:51.723334Z","caller":"traceutil/trace.go:171","msg":"trace[542277732] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:308; }","duration":"133.969329ms","start":"2026-09-18T15:17:51.58933Z","end":"2026-09-18T15:17:51.723299Z","steps":["trace[542277732] 'read index received' (duration: 48.900454ms)","trace[542277732] 'applied index is now lower than readState.Index' (duration: 85.067515ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:51.723416Z","caller":"traceutil/trace.go:171","msg":"trace[2045580201] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"168.385983ms","start":"2026-09-18T15:17:51.555Z","end":"2026-09-18T15:17:51.723386Z","steps":["trace[2045580201] 'process raft request' (duration: 83.139786ms)","trace[2045580201] 'compare' (duration: 84.943264ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:51.723626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.254473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-09-18T15:17:51.723689Z","caller":"traceutil/trace.go:171","msg":"trace[1069833281] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:300; }","duration":"134.409944ms","start":"2026-09-18T15:17:51.589267Z","end":"2026-09-18T15:17:51.723677Z","steps":["trace[1069833281] 'agreement among raft nodes before linearized reading' (duration: 134.177062ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:51.938235Z","caller":"traceutil/trace.go:171","msg":"trace[1992191606] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:309; }","duration":"200.686457ms","start":"2026-09-18T15:17:51.737517Z","end":"2026-09-18T15:17:51.938204Z","steps":["trace[1992191606] 'read index received' (duration: 68.923709ms)","trace[1992191606] 'applied index is now lower than readState.Index' (duration: 131.761578ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:17:51.938623Z","caller":"traceutil/trace.go:171","msg":"trace[1706963151] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"208.360832ms","start":"2026-09-18T15:17:51.730199Z","end":"2026-09-18T15:17:51.93856Z","steps":["trace[1706963151] 'process raft request' (duration: 152.177706ms)","trace[1706963151] 'compare' (duration: 55.65449ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:17:51.938845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.282363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-09-18T15:17:51.938919Z","caller":"traceutil/trace.go:171","msg":"trace[658491130] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:302; }","duration":"201.420054ms","start":"2026-09-18T15:17:51.737486Z","end":"2026-09-18T15:17:51.938906Z","steps":["trace[658491130] 'agreement among raft nodes before linearized reading' (duration: 201.084621ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:52.024861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.034249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-09-18T15:17:52.02489Z","caller":"traceutil/trace.go:171","msg":"trace[54473281] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"214.350849ms","start":"2026-09-18T15:17:51.810496Z","end":"2026-09-18T15:17:52.024847Z","steps":["trace[54473281] 'process raft request' (duration: 214.107017ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:52.024951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.804732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-09-18T15:17:52.024958Z","caller":"traceutil/trace.go:171","msg":"trace[918779868] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:303; }","duration":"136.173141ms","start":"2026-09-18T15:17:51.888755Z","end":"2026-09-18T15:17:52.024928Z","steps":["trace[918779868] 'agreement among raft nodes before linearized reading' (duration: 136.000339ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:17:52.024989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.734487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-09-18T15:17:52.025076Z","caller":"traceutil/trace.go:171","msg":"trace[1992884013] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:303; }","duration":"235.874678ms","start":"2026-09-18T15:17:51.789181Z","end":"2026-09-18T15:17:52.025056Z","steps":["trace[1992884013] 'agreement among raft nodes before linearized reading' (duration: 235.627306ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:17:52.024992Z","caller":"traceutil/trace.go:171","msg":"trace[2049029127] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:303; }","duration":"186.886713ms","start":"2026-09-18T15:17:51.838093Z","end":"2026-09-18T15:17:52.02498Z","steps":["trace[2049029127] 'agreement among raft nodes before linearized reading' (duration: 186.796432ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:07.654122Z","caller":"traceutil/trace.go:171","msg":"trace[253293620] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"325.008158ms","start":"2026-09-18T15:18:07.329068Z","end":"2026-09-18T15:18:07.654077Z","steps":["trace[253293620] 'process raft request' (duration: 324.439358ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:07.655816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:07.329049Z","time spent":"325.140185ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:12.719353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.908108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:18:12.719448Z","caller":"traceutil/trace.go:171","msg":"trace[723164109] linearizableReadLoop","detail":"{readStateIndex:452; appliedIndex:451; }","duration":"118.079553ms","start":"2026-09-18T15:18:12.601342Z","end":"2026-09-18T15:18:12.719422Z","steps":["trace[723164109] 'read index received' (duration: 29.572µs)","trace[723164109] 'applied index is now lower than readState.Index' (duration: 118.048801ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:12.719732Z","caller":"traceutil/trace.go:171","msg":"trace[1138476244] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"188.597783ms","start":"2026-09-18T15:18:12.531123Z","end":"2026-09-18T15:18:12.719721Z","steps":["trace[1138476244] 'process raft request' (duration: 53.129868ms)","trace[1138476244] 'compare' (duration: 134.790512ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:18:12.719932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.585698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:12.719987Z","caller":"traceutil/trace.go:171","msg":"trace[1048712039] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:436; }","duration":"118.642351ms","start":"2026-09-18T15:18:12.601309Z","end":"2026-09-18T15:18:12.719952Z","steps":["trace[1048712039] 'agreement among raft nodes before linearized reading' (duration: 118.573187ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:24.133441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.96432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:24.133536Z","caller":"traceutil/trace.go:171","msg":"trace[558521369] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:495; }","duration":"186.113285ms","start":"2026-09-18T15:18:23.9474Z","end":"2026-09-18T15:18:24.133513Z","steps":["trace[558521369] 'range keys from in-memory index tree' (duration: 185.886756ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:25.040975Z","caller":"traceutil/trace.go:171","msg":"trace[162048956] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"128.536828ms","start":"2026-09-18T15:18:24.912423Z","end":"2026-09-18T15:18:25.04096Z","steps":["trace[162048956] 'process raft request' (duration: 128.295908ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:25.111876Z","caller":"traceutil/trace.go:171","msg":"trace[188057493] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"167.124792ms","start":"2026-09-18T15:18:24.94472Z","end":"2026-09-18T15:18:25.111845Z","steps":["trace[188057493] 'process raft request' (duration: 166.699284ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:30.912594Z","caller":"traceutil/trace.go:171","msg":"trace[1703086139] linearizableReadLoop","detail":"{readStateIndex:627; appliedIndex:626; }","duration":"309.675178ms","start":"2026-09-18T15:18:30.602901Z","end":"2026-09-18T15:18:30.912576Z","steps":["trace[1703086139] 'read index received' (duration: 309.070723ms)","trace[1703086139] 'applied index is now lower than readState.Index' (duration: 603.725µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:18:30.912639Z","caller":"traceutil/trace.go:171","msg":"trace[1140419114] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"437.798064ms","start":"2026-09-18T15:18:30.474808Z","end":"2026-09-18T15:18:30.912606Z","steps":["trace[1140419114] 'process raft request' (duration: 437.250901ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:30.912713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.807853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:30.912737Z","caller":"traceutil/trace.go:171","msg":"trace[595487008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"309.902737ms","start":"2026-09-18T15:18:30.602826Z","end":"2026-09-18T15:18:30.912729Z","steps":["trace[595487008] 'agreement among raft nodes before linearized reading' (duration: 309.847935ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:30.912765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:30.602796Z","time spent":"309.96388ms","remote":"127.0.0.1:56926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-09-18T15:18:30.91278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:30.474785Z","time spent":"437.917769ms","remote":"127.0.0.1:57026","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:30.952686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.078153ms","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-09-18T15:18:30.952782Z","caller":"traceutil/trace.go:171","msg":"trace[875697226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"327.24413ms","start":"2026-09-18T15:18:30.625515Z","end":"2026-09-18T15:18:30.952759Z","steps":["trace[875697226] 'agreement among raft nodes before linearized reading' (duration: 327.053432ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:30.952816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:30.625488Z","time spent":"327.321853ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T15:18:30.952834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.841352ms","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-09-18T15:18:30.953048Z","caller":"traceutil/trace.go:171","msg":"trace[719110099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"126.081803ms","start":"2026-09-18T15:18:30.826906Z","end":"2026-09-18T15:18:30.952988Z","steps":["trace[719110099] 'agreement among raft nodes before linearized reading' (duration: 125.680666ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:30.953315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.840448ms","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-09-18T15:18:30.953409Z","caller":"traceutil/trace.go:171","msg":"trace[36256924] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"131.019005ms","start":"2026-09-18T15:18:30.822372Z","end":"2026-09-18T15:18:30.953391Z","steps":["trace[36256924] 'agreement among raft nodes before linearized reading' (duration: 130.720203ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:31.320456Z","caller":"traceutil/trace.go:171","msg":"trace[514408230] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"363.998582ms","start":"2026-09-18T15:18:30.956438Z","end":"2026-09-18T15:18:31.320436Z","steps":["trace[514408230] 'process raft request' (duration: 363.819305ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:31.320591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:30.956416Z","time spent":"364.101506ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:18:31.573626Z","caller":"traceutil/trace.go:171","msg":"trace[130548542] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"588.265616ms","start":"2026-09-18T15:18:30.985329Z","end":"2026-09-18T15:18:31.573594Z","steps":["trace[130548542] 'process raft request' (duration: 588.109309ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:31.574145Z","caller":"traceutil/trace.go:171","msg":"trace[1026651005] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"616.927084ms","start":"2026-09-18T15:18:30.957202Z","end":"2026-09-18T15:18:31.574129Z","steps":["trace[1026651005] 'process raft request' (duration: 616.132321ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:31.574591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:30.985312Z","time spent":"588.392091ms","remote":"127.0.0.1:57432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-18T15:18:31.574807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:30.957197Z","time spent":"617.378793ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-18T15:18:31.574414Z","caller":"traceutil/trace.go:171","msg":"trace[597171273] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"617.198145ms","start":"2026-09-18T15:18:30.957139Z","end":"2026-09-18T15:18:31.574337Z","steps":["trace[597171273] 'process raft request' (duration: 615.913963ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:31.575201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:30.95712Z","time spent":"618.05247ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-18T15:18:52.0322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.731522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.032274Z","caller":"traceutil/trace.go:171","msg":"trace[1065702239] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:784; }","duration":"345.827636ms","start":"2026-09-18T15:18:51.686431Z","end":"2026-09-18T15:18:52.032259Z","steps":["trace[1065702239] 'count revisions from in-memory index tree' (duration: 345.699672ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.032312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.686427Z","time spent":"345.873347ms","remote":"127.0.0.1:43848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-09-18T15:18:52.032401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.00754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.032422Z","caller":"traceutil/trace.go:171","msg":"trace[395043091] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:784; }","duration":"154.043001ms","start":"2026-09-18T15:18:51.878374Z","end":"2026-09-18T15:18:52.032417Z","steps":["trace[395043091] 'range keys from in-memory index tree' (duration: 153.935858ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.032456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.640292ms","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-09-18T15:18:52.032567Z","caller":"traceutil/trace.go:171","msg":"trace[1681158364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:784; }","duration":"202.810998ms","start":"2026-09-18T15:18:51.82974Z","end":"2026-09-18T15:18:52.032551Z","steps":["trace[1681158364] 'range keys from in-memory index tree' (duration: 202.605811ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.032607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.333318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.032633Z","caller":"traceutil/trace.go:171","msg":"trace[1115859022] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:784; }","duration":"185.381479ms","start":"2026-09-18T15:18:51.847246Z","end":"2026-09-18T15:18:52.032627Z","steps":["trace[1115859022] 'count revisions from in-memory index tree' (duration: 185.270446ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.032617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.24107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.032726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.309057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.032708Z","caller":"traceutil/trace.go:171","msg":"trace[559015851] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:784; }","duration":"346.317072ms","start":"2026-09-18T15:18:51.68637Z","end":"2026-09-18T15:18:52.032687Z","steps":["trace[559015851] 'range keys from in-memory index tree' (duration: 346.107424ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.032747Z","caller":"traceutil/trace.go:171","msg":"trace[413976966] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:784; }","duration":"185.375759ms","start":"2026-09-18T15:18:51.847367Z","end":"2026-09-18T15:18:52.032742Z","steps":["trace[413976966] 'range keys from in-memory index tree' (duration: 185.243395ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.032815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.294216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.032834Z","caller":"traceutil/trace.go:171","msg":"trace[1323339110] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:784; }","duration":"185.357059ms","start":"2026-09-18T15:18:51.847472Z","end":"2026-09-18T15:18:52.032829Z","steps":["trace[1323339110] 'range keys from in-memory index tree' (duration: 185.253485ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.032776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.686327Z","time spent":"346.437896ms","remote":"127.0.0.1:43848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-09-18T15:18:52.032918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.80215ms","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-09-18T15:18:52.032932Z","caller":"traceutil/trace.go:171","msg":"trace[1478960336] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:784; }","duration":"168.82711ms","start":"2026-09-18T15:18:51.8641Z","end":"2026-09-18T15:18:52.032928Z","steps":["trace[1478960336] 'count revisions from in-memory index tree' (duration: 168.769969ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.032982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.308898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.033014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.560941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.033035Z","caller":"traceutil/trace.go:171","msg":"trace[1816002454] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:784; }","duration":"168.605953ms","start":"2026-09-18T15:18:51.864424Z","end":"2026-09-18T15:18:52.03303Z","steps":["trace[1816002454] 'range keys from in-memory index tree' (duration: 168.453558ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.033027Z","caller":"traceutil/trace.go:171","msg":"trace[17849413] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:784; }","duration":"289.355489ms","start":"2026-09-18T15:18:51.743663Z","end":"2026-09-18T15:18:52.033019Z","steps":["trace[17849413] 'range keys from in-memory index tree' (duration: 289.265876ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.47578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.033163Z","caller":"traceutil/trace.go:171","msg":"trace[446407101] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:784; }","duration":"155.508561ms","start":"2026-09-18T15:18:51.87765Z","end":"2026-09-18T15:18:52.033159Z","steps":["trace[446407101] 'range keys from in-memory index tree' (duration: 155.408598ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.547772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.033318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.642717ms","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-09-18T15:18:52.033358Z","caller":"traceutil/trace.go:171","msg":"trace[1394307732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:784; }","duration":"278.708589ms","start":"2026-09-18T15:18:51.754641Z","end":"2026-09-18T15:18:52.03335Z","steps":["trace[1394307732] 'range keys from in-memory index tree' (duration: 278.497263ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.584918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-18T15:18:52.033404Z","caller":"traceutil/trace.go:171","msg":"trace[1817175810] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:784; }","duration":"143.63169ms","start":"2026-09-18T15:18:51.889767Z","end":"2026-09-18T15:18:52.033399Z","steps":["trace[1817175810] 'range keys from in-memory index tree' (duration: 143.479584ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.454716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.033507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.246196ms","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-09-18T15:18:52.033521Z","caller":"traceutil/trace.go:171","msg":"trace[627351694] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:784; }","duration":"155.849212ms","start":"2026-09-18T15:18:51.877665Z","end":"2026-09-18T15:18:52.033514Z","steps":["trace[627351694] 'count revisions from in-memory index tree' (duration: 155.51006ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.033533Z","caller":"traceutil/trace.go:171","msg":"trace[1713222201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:784; }","duration":"300.281787ms","start":"2026-09-18T15:18:51.733244Z","end":"2026-09-18T15:18:52.033526Z","steps":["trace[1713222201] 'range keys from in-memory index tree' (duration: 300.157264ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.033535Z","caller":"traceutil/trace.go:171","msg":"trace[575648738] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:784; }","duration":"346.739976ms","start":"2026-09-18T15:18:51.68677Z","end":"2026-09-18T15:18:52.03351Z","steps":["trace[575648738] 'range keys from in-memory index tree' (duration: 346.366933ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.07175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.033573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.733165Z","time spent":"300.382171ms","remote":"127.0.0.1:57196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-09-18T15:18:52.033574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.252316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.033586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.938506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.033612Z","caller":"traceutil/trace.go:171","msg":"trace[1877623615] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:784; }","duration":"204.201844ms","start":"2026-09-18T15:18:51.829383Z","end":"2026-09-18T15:18:52.033585Z","steps":["trace[1877623615] 'count revisions from in-memory index tree' (duration: 204.046009ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.167276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.033698Z","caller":"traceutil/trace.go:171","msg":"trace[1146690097] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:784; }","duration":"290.219688ms","start":"2026-09-18T15:18:51.743473Z","end":"2026-09-18T15:18:52.033693Z","steps":["trace[1146690097] 'count revisions from in-memory index tree' (duration: 290.140706ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.393673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.03373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.337864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.033635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.882991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.033749Z","caller":"traceutil/trace.go:171","msg":"trace[1422828474] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"317.388705ms","start":"2026-09-18T15:18:51.716354Z","end":"2026-09-18T15:18:52.033742Z","steps":["trace[1422828474] 'count revisions from in-memory index tree' (duration: 317.274952ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.033761Z","caller":"traceutil/trace.go:171","msg":"trace[819308955] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:784; }","duration":"274.456746ms","start":"2026-09-18T15:18:51.759281Z","end":"2026-09-18T15:18:52.033738Z","steps":["trace[819308955] 'range keys from in-memory index tree' (duration: 274.311651ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.03377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.716335Z","time spent":"317.430196ms","remote":"127.0.0.1:43850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-09-18T15:18:52.032901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.025897ms","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-09-18T15:18:52.033865Z","caller":"traceutil/trace.go:171","msg":"trace[245142729] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:784; }","duration":"170.00784ms","start":"2026-09-18T15:18:51.863848Z","end":"2026-09-18T15:18:52.033855Z","steps":["trace[245142729] 'range keys from in-memory index tree' (duration: 168.911943ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.755584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.033864Z","caller":"traceutil/trace.go:171","msg":"trace[961431562] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:784; }","duration":"275.189121ms","start":"2026-09-18T15:18:51.758628Z","end":"2026-09-18T15:18:52.033817Z","steps":["trace[961431562] 'range keys from in-memory index tree' (duration: 274.748666ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.033894Z","caller":"traceutil/trace.go:171","msg":"trace[1176459918] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"300.792984ms","start":"2026-09-18T15:18:51.733096Z","end":"2026-09-18T15:18:52.033889Z","steps":["trace[1176459918] 'range keys from in-memory index tree' (duration: 300.708102ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.733081Z","time spent":"300.825176ms","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-09-18T15:18:52.032584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.991217ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.033975Z","caller":"traceutil/trace.go:171","msg":"trace[1697333558] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:784; }","duration":"290.56837ms","start":"2026-09-18T15:18:51.743401Z","end":"2026-09-18T15:18:52.033969Z","steps":["trace[1697333558] 'range keys from in-memory index tree' (duration: 288.877623ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.796275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-09-18T15:18:52.033706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.322483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.034065Z","caller":"traceutil/trace.go:171","msg":"trace[629607435] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"300.877458ms","start":"2026-09-18T15:18:51.733181Z","end":"2026-09-18T15:18:52.034059Z","steps":["trace[629607435] 'count revisions from in-memory index tree' (duration: 300.739603ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.845586ms","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-09-18T15:18:52.034132Z","caller":"traceutil/trace.go:171","msg":"trace[1475060547] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:784; }","duration":"236.900818ms","start":"2026-09-18T15:18:51.797195Z","end":"2026-09-18T15:18:52.034096Z","steps":["trace[1475060547] 'range keys from in-memory index tree' (duration: 236.774084ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.034093Z","caller":"traceutil/trace.go:171","msg":"trace[818173709] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"317.782458ms","start":"2026-09-18T15:18:51.716302Z","end":"2026-09-18T15:18:52.034084Z","steps":["trace[818173709] 'range keys from in-memory index tree' (duration: 317.269911ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.716288Z","time spent":"317.904512ms","remote":"127.0.0.1:43850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-09-18T15:18:52.034231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.542232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.034251Z","caller":"traceutil/trace.go:171","msg":"trace[323876180] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:784; }","duration":"275.573353ms","start":"2026-09-18T15:18:51.75867Z","end":"2026-09-18T15:18:52.034243Z","steps":["trace[323876180] 'count revisions from in-memory index tree' (duration: 275.509881ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:52.033654Z","caller":"traceutil/trace.go:171","msg":"trace[2094534222] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:784; }","duration":"236.389501ms","start":"2026-09-18T15:18:51.79725Z","end":"2026-09-18T15:18:52.033639Z","steps":["trace[2094534222] 'count revisions from in-memory index tree' (duration: 236.143363ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.033564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.686765Z","time spent":"346.788657ms","remote":"127.0.0.1:43848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"info","ts":"2026-09-18T15:18:52.033653Z","caller":"traceutil/trace.go:171","msg":"trace[1610760281] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:784; }","duration":"300.010738ms","start":"2026-09-18T15:18:51.733634Z","end":"2026-09-18T15:18:52.033645Z","steps":["trace[1610760281] 'range keys from in-memory index tree' (duration: 299.911225ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.733629Z","time spent":"301.058723ms","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-09-18T15:18:52.034083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-18T15:18:51.733165Z","time spent":"300.911668ms","remote":"127.0.0.1:43864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-09-18T15:18:52.033946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.575557ms","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-09-18T15:18:52.034765Z","caller":"traceutil/trace.go:171","msg":"trace[1198774591] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:784; }","duration":"205.434645ms","start":"2026-09-18T15:18:51.829322Z","end":"2026-09-18T15:18:52.034757Z","steps":["trace[1198774591] 'range keys from in-memory index tree' (duration: 204.455323ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.52875ms","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-09-18T15:18:52.034882Z","caller":"traceutil/trace.go:171","msg":"trace[285688853] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:784; }","duration":"121.016256ms","start":"2026-09-18T15:18:51.913856Z","end":"2026-09-18T15:18:52.034872Z","steps":["trace[285688853] 'count revisions from in-memory index tree' (duration: 120.468807ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.673864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.034992Z","caller":"traceutil/trace.go:171","msg":"trace[1231914561] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:784; }","duration":"121.244653ms","start":"2026-09-18T15:18:51.913723Z","end":"2026-09-18T15:18:52.034967Z","steps":["trace[1231914561] 'range keys from in-memory index tree' (duration: 120.653113ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.628674ms","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-09-18T15:18:52.035117Z","caller":"traceutil/trace.go:171","msg":"trace[1805463073] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:784; }","duration":"140.341288ms","start":"2026-09-18T15:18:51.894769Z","end":"2026-09-18T15:18:52.03511Z","steps":["trace[1805463073] 'range keys from in-memory index tree' (duration: 139.5094ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.219671ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.035199Z","caller":"traceutil/trace.go:171","msg":"trace[54964151] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:784; }","duration":"139.985306ms","start":"2026-09-18T15:18:51.895203Z","end":"2026-09-18T15:18:52.035188Z","steps":["trace[54964151] 'range keys from in-memory index tree' (duration: 139.173829ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.581383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.035333Z","caller":"traceutil/trace.go:171","msg":"trace[695505190] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:784; }","duration":"140.482293ms","start":"2026-09-18T15:18:51.894843Z","end":"2026-09-18T15:18:52.035326Z","steps":["trace[695505190] 'count revisions from in-memory index tree' (duration: 139.549302ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:18:52.034467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.008205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:18:52.035399Z","caller":"traceutil/trace.go:171","msg":"trace[93392962] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:784; }","duration":"121.961367ms","start":"2026-09-18T15:18:51.913429Z","end":"2026-09-18T15:18:52.03539Z","steps":["trace[93392962] 'range keys from in-memory index tree' (duration: 120.935213ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:57.580571Z","caller":"traceutil/trace.go:171","msg":"trace[398739380] transaction","detail":"{read_only:false; response_revision:849; number_of_response:1; }","duration":"132.399296ms","start":"2026-09-18T15:18:57.448151Z","end":"2026-09-18T15:18:57.58055Z","steps":["trace[398739380] 'process raft request' (duration: 132.260882ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:57.795719Z","caller":"traceutil/trace.go:171","msg":"trace[2028671403] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"109.552873ms","start":"2026-09-18T15:18:57.686141Z","end":"2026-09-18T15:18:57.795694Z","steps":["trace[2028671403] 'process raft request' (duration: 108.639724ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:18:57.795729Z","caller":"traceutil/trace.go:171","msg":"trace[2100909814] transaction","detail":"{read_only:false; response_revision:854; number_of_response:1; }","duration":"104.296735ms","start":"2026-09-18T15:18:57.69141Z","end":"2026-09-18T15:18:57.795707Z","steps":["trace[2100909814] 'process raft request' (duration: 104.199871ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:20.589597Z","caller":"traceutil/trace.go:171","msg":"trace[543525451] transaction","detail":"{read_only:false; response_revision:1186; number_of_response:1; }","duration":"242.232833ms","start":"2026-09-18T15:19:20.347343Z","end":"2026-09-18T15:19:20.589576Z","steps":["trace[543525451] 'process raft request' (duration: 241.298958ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:19:20.590598Z","caller":"traceutil/trace.go:171","msg":"trace[834516719] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"242.87905ms","start":"2026-09-18T15:19:20.34769Z","end":"2026-09-18T15:19:20.590569Z","steps":["trace[834516719] 'process raft request' (duration: 242.728556ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:19:34.554782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.116066ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-18T15:19:34.554894Z","caller":"traceutil/trace.go:171","msg":"trace[811273491] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"142.591459ms","start":"2026-09-18T15:19:34.412287Z","end":"2026-09-18T15:19:34.554879Z","steps":["trace[811273491] 'compare' (duration: 132.990713ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:06.072185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.068483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dcdc8986-2ff7-4ded-b386-bdf557f5c9d1\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-09-18T15:20:06.072283Z","caller":"traceutil/trace.go:171","msg":"trace[276441318] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dcdc8986-2ff7-4ded-b386-bdf557f5c9d1; range_end:; response_count:1; response_revision:1834; }","duration":"171.239876ms","start":"2026-09-18T15:20:05.901022Z","end":"2026-09-18T15:20:06.072261Z","steps":["trace[276441318] 'range keys from in-memory index tree' (duration: 170.639153ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:06.273602Z","caller":"traceutil/trace.go:171","msg":"trace[1442852897] linearizableReadLoop","detail":"{readStateIndex:1907; appliedIndex:1905; }","duration":"185.385179ms","start":"2026-09-18T15:20:06.088182Z","end":"2026-09-18T15:20:06.273567Z","steps":["trace[1442852897] 'read index received' (duration: 19.099126ms)","trace[1442852897] 'applied index is now lower than readState.Index' (duration: 166.283963ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:20:06.273738Z","caller":"traceutil/trace.go:171","msg":"trace[789533512] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"194.038699ms","start":"2026-09-18T15:20:06.079635Z","end":"2026-09-18T15:20:06.273674Z","steps":["trace[789533512] 'process raft request' (duration: 182.578591ms)","trace[789533512] 'compare' (duration: 11.115971ms)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:20:06.273848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.611955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:20:06.273911Z","caller":"traceutil/trace.go:171","msg":"trace[765539470] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1836; }","duration":"185.771428ms","start":"2026-09-18T15:20:06.088124Z","end":"2026-09-18T15:20:06.273895Z","steps":["trace[765539470] 'agreement among raft nodes before linearized reading' (duration: 185.607085ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:06.291666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.948254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-dcdc8986-2ff7-4ded-b386-bdf557f5c9d1\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-09-18T15:20:06.291755Z","caller":"traceutil/trace.go:171","msg":"trace[966233761] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-dcdc8986-2ff7-4ded-b386-bdf557f5c9d1; range_end:; response_count:1; response_revision:1837; }","duration":"138.107737ms","start":"2026-09-18T15:20:06.153626Z","end":"2026-09-18T15:20:06.291734Z","steps":["trace[966233761] 'agreement among raft nodes before linearized reading' (duration: 137.947874ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:06.291793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.212489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-18T15:20:06.291831Z","caller":"traceutil/trace.go:171","msg":"trace[269255834] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1837; }","duration":"149.28825ms","start":"2026-09-18T15:20:06.142528Z","end":"2026-09-18T15:20:06.291816Z","steps":["trace[269255834] 'agreement among raft nodes before linearized reading' (duration: 149.202588ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:06.291705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.937735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-09-18T15:20:06.291953Z","caller":"traceutil/trace.go:171","msg":"trace[1946128022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1837; }","duration":"165.18623ms","start":"2026-09-18T15:20:06.126753Z","end":"2026-09-18T15:20:06.291939Z","steps":["trace[1946128022] 'agreement among raft nodes before linearized reading' (duration: 164.744551ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:19.108702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.373594ms","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-09-18T15:20:19.108827Z","caller":"traceutil/trace.go:171","msg":"trace[50419928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1949; }","duration":"210.552148ms","start":"2026-09-18T15:20:18.898261Z","end":"2026-09-18T15:20:19.108813Z","steps":["trace[50419928] 'range keys from in-memory index tree' (duration: 210.2084ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:19.10874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.535728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-18T15:20:19.108977Z","caller":"traceutil/trace.go:171","msg":"trace[743957511] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1949; }","duration":"206.823204ms","start":"2026-09-18T15:20:18.902136Z","end":"2026-09-18T15:20:19.108959Z","steps":["trace[743957511] 'range keys from in-memory index tree' (duration: 206.354464ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:39.704349Z","caller":"traceutil/trace.go:171","msg":"trace[303055933] transaction","detail":"{read_only:false; response_revision:2076; number_of_response:1; }","duration":"166.954788ms","start":"2026-09-18T15:20:39.537372Z","end":"2026-09-18T15:20:39.704327Z","steps":["trace[303055933] 'process raft request' (duration: 166.818356ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:39.704366Z","caller":"traceutil/trace.go:171","msg":"trace[1477337452] linearizableReadLoop","detail":"{readStateIndex:2154; appliedIndex:2154; }","duration":"127.44264ms","start":"2026-09-18T15:20:39.57688Z","end":"2026-09-18T15:20:39.704322Z","steps":["trace[1477337452] 'read index received' (duration: 127.43259ms)","trace[1477337452] 'applied index is now lower than readState.Index' (duration: 8.3µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:20:39.704576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.682635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12385"} {"level":"info","ts":"2026-09-18T15:20:39.704642Z","caller":"traceutil/trace.go:171","msg":"trace[325198069] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2076; }","duration":"127.802677ms","start":"2026-09-18T15:20:39.576826Z","end":"2026-09-18T15:20:39.704628Z","steps":["trace[325198069] 'agreement among raft nodes before linearized reading' (duration: 127.590513ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:39.712523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.975577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-18T15:20:39.712589Z","caller":"traceutil/trace.go:171","msg":"trace[1033236938] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2077; }","duration":"111.068209ms","start":"2026-09-18T15:20:39.601499Z","end":"2026-09-18T15:20:39.712567Z","steps":["trace[1033236938] 'agreement among raft nodes before linearized reading' (duration: 110.995217ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:40.689086Z","caller":"traceutil/trace.go:171","msg":"trace[207545442] transaction","detail":"{read_only:false; response_revision:2080; number_of_response:1; }","duration":"221.071044ms","start":"2026-09-18T15:20:40.467957Z","end":"2026-09-18T15:20:40.689028Z","steps":["trace[207545442] 'process raft request' (duration: 220.794429ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:20:40.689074Z","caller":"traceutil/trace.go:171","msg":"trace[1834686370] linearizableReadLoop","detail":"{readStateIndex:2158; appliedIndex:2157; }","duration":"181.721741ms","start":"2026-09-18T15:20:40.507283Z","end":"2026-09-18T15:20:40.689005Z","steps":["trace[1834686370] 'read index received' (duration: 181.340694ms)","trace[1834686370] 'applied index is now lower than readState.Index' (duration: 379.387µs)"],"step_count":2} {"level":"warn","ts":"2026-09-18T15:20:40.69008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.74355ms","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-09-18T15:20:40.69019Z","caller":"traceutil/trace.go:171","msg":"trace[1663216582] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2080; }","duration":"183.566435ms","start":"2026-09-18T15:20:40.506595Z","end":"2026-09-18T15:20:40.690161Z","steps":["trace[1663216582] 'agreement among raft nodes before linearized reading' (duration: 182.560747ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:40.690705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.267444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-18T15:20:40.690774Z","caller":"traceutil/trace.go:171","msg":"trace[315234794] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2080; }","duration":"174.384916ms","start":"2026-09-18T15:20:40.516369Z","end":"2026-09-18T15:20:40.690754Z","steps":["trace[315234794] 'agreement among raft nodes before linearized reading' (duration: 174.162042ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:41.023707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.030881ms","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-09-18T15:20:41.023762Z","caller":"traceutil/trace.go:171","msg":"trace[824795623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2081; }","duration":"154.144182ms","start":"2026-09-18T15:20:40.869605Z","end":"2026-09-18T15:20:41.02375Z","steps":["trace[824795623] 'range keys from in-memory index tree' (duration: 153.862897ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:41.024334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.917912ms","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-09-18T15:20:41.024435Z","caller":"traceutil/trace.go:171","msg":"trace[338249114] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2081; }","duration":"257.047374ms","start":"2026-09-18T15:20:40.767369Z","end":"2026-09-18T15:20:41.024417Z","steps":["trace[338249114] 'range keys from in-memory index tree' (duration: 256.184229ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:20:41.026475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.1628ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-09-18T15:21:38.803561Z","caller":"traceutil/trace.go:171","msg":"trace[368183840] linearizableReadLoop","detail":"{readStateIndex:2540; appliedIndex:2539; }","duration":"100.722329ms","start":"2026-09-18T15:21:38.702818Z","end":"2026-09-18T15:21:38.80354Z","steps":["trace[368183840] 'read index received' (duration: 100.466635ms)","trace[368183840] 'applied index is now lower than readState.Index' (duration: 255.114µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:21:38.803664Z","caller":"traceutil/trace.go:171","msg":"trace[470119587] transaction","detail":"{read_only:false; response_revision:2448; number_of_response:1; }","duration":"280.227947ms","start":"2026-09-18T15:21:38.523404Z","end":"2026-09-18T15:21:38.803632Z","steps":["trace[470119587] 'process raft request' (duration: 279.953102ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:38.803751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.918772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:2917"} {"level":"info","ts":"2026-09-18T15:21:38.803793Z","caller":"traceutil/trace.go:171","msg":"trace[1854503712] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:2448; }","duration":"101.015844ms","start":"2026-09-18T15:21:38.702768Z","end":"2026-09-18T15:21:38.803784Z","steps":["trace[1854503712] 'agreement among raft nodes before linearized reading' (duration: 100.866762ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:47.660724Z","caller":"traceutil/trace.go:171","msg":"trace[1243573467] linearizableReadLoop","detail":"{readStateIndex:2632; appliedIndex:2631; }","duration":"260.69789ms","start":"2026-09-18T15:21:47.400008Z","end":"2026-09-18T15:21:47.660706Z","steps":["trace[1243573467] 'read index received' (duration: 260.574968ms)","trace[1243573467] 'applied index is now lower than readState.Index' (duration: 122.432µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:21:47.66079Z","caller":"traceutil/trace.go:171","msg":"trace[619392034] transaction","detail":"{read_only:false; response_revision:2538; number_of_response:1; }","duration":"274.653697ms","start":"2026-09-18T15:21:47.386114Z","end":"2026-09-18T15:21:47.660768Z","steps":["trace[619392034] 'process raft request' (duration: 274.503255ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:47.660861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.996396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-09-18T15:21:47.660886Z","caller":"traceutil/trace.go:171","msg":"trace[591995679] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2538; }","duration":"227.054446ms","start":"2026-09-18T15:21:47.433824Z","end":"2026-09-18T15:21:47.660878Z","steps":["trace[591995679] 'agreement among raft nodes before linearized reading' (duration: 226.962125ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:47.660932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.902545ms","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-09-18T15:21:47.66096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.402136ms","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-09-18T15:21:47.660998Z","caller":"traceutil/trace.go:171","msg":"trace[940351375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2538; }","duration":"261.008886ms","start":"2026-09-18T15:21:47.399974Z","end":"2026-09-18T15:21:47.660983Z","steps":["trace[940351375] 'agreement among raft nodes before linearized reading' (duration: 260.817303ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:21:47.661003Z","caller":"traceutil/trace.go:171","msg":"trace[1170447160] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2538; }","duration":"105.488518ms","start":"2026-09-18T15:21:47.555503Z","end":"2026-09-18T15:21:47.660992Z","steps":["trace[1170447160] 'agreement among raft nodes before linearized reading' (duration: 105.387426ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:47.660956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.366078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-09-18T15:21:47.66109Z","caller":"traceutil/trace.go:171","msg":"trace[1606536092] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2538; }","duration":"115.556881ms","start":"2026-09-18T15:21:47.545523Z","end":"2026-09-18T15:21:47.66108Z","steps":["trace[1606536092] 'agreement among raft nodes before linearized reading' (duration: 115.376538ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:21:51.73602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.772983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-09-18T15:21:51.736099Z","caller":"traceutil/trace.go:171","msg":"trace[1894568377] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2557; }","duration":"103.902085ms","start":"2026-09-18T15:21:51.63218Z","end":"2026-09-18T15:21:51.736082Z","steps":["trace[1894568377] 'range keys from in-memory index tree' (duration: 103.507818ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:18.183128Z","caller":"traceutil/trace.go:171","msg":"trace[194500424] linearizableReadLoop","detail":"{readStateIndex:2806; appliedIndex:2805; }","duration":"267.682629ms","start":"2026-09-18T15:22:17.915418Z","end":"2026-09-18T15:22:18.1831Z","steps":["trace[194500424] 'read index received' (duration: 267.420938ms)","trace[194500424] 'applied index is now lower than readState.Index' (duration: 260.491µs)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:22:18.183504Z","caller":"traceutil/trace.go:171","msg":"trace[84476216] transaction","detail":"{read_only:false; response_revision:2705; number_of_response:1; }","duration":"271.671639ms","start":"2026-09-18T15:22:17.911807Z","end":"2026-09-18T15:22:18.183479Z","steps":["trace[84476216] 'process raft request' (duration: 271.099475ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:18.183869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.429291ms","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-09-18T15:22:18.183974Z","caller":"traceutil/trace.go:171","msg":"trace[590225620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2705; }","duration":"268.561666ms","start":"2026-09-18T15:22:17.915394Z","end":"2026-09-18T15:22:18.183956Z","steps":["trace[590225620] 'agreement among raft nodes before linearized reading' (duration: 268.336067ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:22:18.198142Z","caller":"traceutil/trace.go:171","msg":"trace[1827181600] transaction","detail":"{read_only:false; response_revision:2706; number_of_response:1; }","duration":"142.536636ms","start":"2026-09-18T15:22:18.055576Z","end":"2026-09-18T15:22:18.198113Z","steps":["trace[1827181600] 'process raft request' (duration: 142.049095ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:18.198355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.512845ms","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-09-18T15:22:18.198423Z","caller":"traceutil/trace.go:171","msg":"trace[932825771] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2707; }","duration":"262.657361ms","start":"2026-09-18T15:22:17.935748Z","end":"2026-09-18T15:22:18.198406Z","steps":["trace[932825771] 'agreement among raft nodes before linearized reading' (duration: 262.419481ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:18.198374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.794427ms","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-09-18T15:22:18.198489Z","caller":"traceutil/trace.go:171","msg":"trace[1127284875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2707; }","duration":"262.947033ms","start":"2026-09-18T15:22:17.93553Z","end":"2026-09-18T15:22:18.198477Z","steps":["trace[1127284875] 'agreement among raft nodes before linearized reading' (duration: 262.762655ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:22:18.199005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.487682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"info","ts":"2026-09-18T15:22:18.199222Z","caller":"traceutil/trace.go:171","msg":"trace[410622666] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:2707; }","duration":"265.805256ms","start":"2026-09-18T15:22:17.933387Z","end":"2026-09-18T15:22:18.199192Z","steps":["trace[410622666] 'agreement among raft nodes before linearized reading' (duration: 264.775002ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:38.830071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.90241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-f78fc5489-t8gtf.18d673c65b475b77\" ","response":"range_response_count:1 size:893"} {"level":"info","ts":"2026-09-18T15:26:38.830151Z","caller":"traceutil/trace.go:171","msg":"trace[590750054] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-f78fc5489-t8gtf.18d673c65b475b77; range_end:; response_count:1; response_revision:4846; }","duration":"118.000562ms","start":"2026-09-18T15:26:38.712133Z","end":"2026-09-18T15:26:38.830133Z","steps":["trace[590750054] 'range keys from in-memory index tree' (duration: 117.789328ms)"],"step_count":1} {"level":"warn","ts":"2026-09-18T15:26:38.830338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.818181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-2175f772-01e7-4c4f-9f8c-0a05d4dcb4bc\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-09-18T15:26:38.830432Z","caller":"traceutil/trace.go:171","msg":"trace[551696795] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-2175f772-01e7-4c4f-9f8c-0a05d4dcb4bc; range_end:; response_count:1; response_revision:4846; }","duration":"119.957524ms","start":"2026-09-18T15:26:38.710458Z","end":"2026-09-18T15:26:38.830416Z","steps":["trace[551696795] 'range keys from in-memory index tree' (duration: 119.575606ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:41.778343Z","caller":"traceutil/trace.go:171","msg":"trace[2044369464] transaction","detail":"{read_only:false; response_revision:4885; number_of_response:1; }","duration":"142.71609ms","start":"2026-09-18T15:26:41.63561Z","end":"2026-09-18T15:26:41.778326Z","steps":["trace[2044369464] 'process raft request' (duration: 142.614078ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:41.780142Z","caller":"traceutil/trace.go:171","msg":"trace[849422641] transaction","detail":"{read_only:false; response_revision:4886; number_of_response:1; }","duration":"124.38355ms","start":"2026-09-18T15:26:41.655737Z","end":"2026-09-18T15:26:41.78012Z","steps":["trace[849422641] 'process raft request' (duration: 124.226476ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:46.858195Z","caller":"traceutil/trace.go:171","msg":"trace[2074403459] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"172.906903ms","start":"2026-09-18T15:26:46.685234Z","end":"2026-09-18T15:26:46.858141Z","steps":["trace[2074403459] 'process raft request' (duration: 172.663698ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:51.398563Z","caller":"traceutil/trace.go:171","msg":"trace[109924091] transaction","detail":"{read_only:false; response_revision:5012; number_of_response:1; }","duration":"137.398705ms","start":"2026-09-18T15:26:51.261148Z","end":"2026-09-18T15:26:51.398547Z","steps":["trace[109924091] 'process raft request' (duration: 137.276553ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:52.010815Z","caller":"traceutil/trace.go:171","msg":"trace[1593059122] transaction","detail":"{read_only:false; response_revision:5016; number_of_response:1; }","duration":"135.826731ms","start":"2026-09-18T15:26:51.874969Z","end":"2026-09-18T15:26:52.010795Z","steps":["trace[1593059122] 'process raft request' (duration: 123.167805ms)","trace[1593059122] 'compare' (duration: 12.508143ms)"],"step_count":2} {"level":"info","ts":"2026-09-18T15:26:52.01124Z","caller":"traceutil/trace.go:171","msg":"trace[1244495876] transaction","detail":"{read_only:false; response_revision:5017; number_of_response:1; }","duration":"136.125608ms","start":"2026-09-18T15:26:51.875074Z","end":"2026-09-18T15:26:52.0112Z","steps":["trace[1244495876] 'process raft request' (duration: 135.689879ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:52.012556Z","caller":"traceutil/trace.go:171","msg":"trace[1367433565] transaction","detail":"{read_only:false; response_revision:5018; number_of_response:1; }","duration":"137.446086ms","start":"2026-09-18T15:26:51.875093Z","end":"2026-09-18T15:26:52.012539Z","steps":["trace[1367433565] 'process raft request' (duration: 136.058287ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:52.012804Z","caller":"traceutil/trace.go:171","msg":"trace[937772781] transaction","detail":"{read_only:false; response_revision:5020; number_of_response:1; }","duration":"133.462302ms","start":"2026-09-18T15:26:51.879324Z","end":"2026-09-18T15:26:52.012786Z","steps":["trace[937772781] 'process raft request' (duration: 132.794708ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:26:52.012902Z","caller":"traceutil/trace.go:171","msg":"trace[284628551] transaction","detail":"{read_only:false; response_revision:5019; number_of_response:1; }","duration":"137.787483ms","start":"2026-09-18T15:26:51.875108Z","end":"2026-09-18T15:26:52.012895Z","steps":["trace[284628551] 'process raft request' (duration: 136.937665ms)"],"step_count":1} {"level":"info","ts":"2026-09-18T15:27:42.484688Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2839} {"level":"info","ts":"2026-09-18T15:27:42.651632Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2839,"took":"165.213375ms","hash":3917993445,"current-db-size-bytes":52875264,"current-db-size":"53 MB","current-db-size-in-use-bytes":29048832,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-09-18T15:27:42.651715Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3917993445,"revision":2839,"compact-revision":-1} {"level":"info","ts":"2026-09-18T15:32:42.491514Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5459} {"level":"info","ts":"2026-09-18T15:32:42.568308Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5459,"took":"75.033471ms","hash":3389677406,"current-db-size-bytes":52875264,"current-db-size":"53 MB","current-db-size-in-use-bytes":18284544,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-09-18T15:32:42.568385Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3389677406,"revision":5459,"compact-revision":2839}