{"level":"warn","ts":"2026-06-08T22:07:42.522833Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T22:07:42.52293Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-08T22:07:42.523136Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-08T22:07:42.523155Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-08T22:07:42.523254Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-08T22:07:42.5239Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-06-08T22:07:42.524015Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-08T22:07:42.529775Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.513183ms"} {"level":"info","ts":"2026-06-08T22:07:42.540479Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-06-08T22:07:42.54057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-06-08T22:07:42.540762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-06-08T22:07:42.540829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-08T22:07:42.540906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-06-08T22:07:42.541021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-06-08T22:07:42.547818Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-08T22:07:42.549624Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-08T22:07:42.551019Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-08T22:07:42.553415Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-08T22:07:42.553615Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-08T22:07:42.553711Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-08T22:07:42.553824Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-08T22:07:42.553837Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-08T22:07:42.5554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-06-08T22:07:42.555767Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-06-08T22:07:42.557555Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-08T22:07:42.557688Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-08T22:07:42.557752Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-06-08T22:07:42.557942Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-08T22:07:42.557991Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-08T22:07:43.242162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-06-08T22:07:43.242225Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-06-08T22:07:43.242277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-06-08T22:07:43.242297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-06-08T22:07:43.242309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-08T22:07:43.242325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-06-08T22:07:43.242347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-06-08T22:07:43.243727Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T22:07:43.244556Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-06-08T22:07:43.244782Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T22:07:43.244981Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-08T22:07:43.245038Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-08T22:07:43.244885Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-08T22:07:43.245437Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T22:07:43.245631Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T22:07:43.245684Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-08T22:07:43.24808Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-06-08T22:07:43.249992Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-06-08T22:07:51.611273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.470843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/disruption-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-08T22:07:51.611364Z","caller":"traceutil/trace.go:171","msg":"trace[1006942382] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/disruption-controller; range_end:; response_count:1; response_revision:291; }","duration":"116.625393ms","start":"2026-06-08T22:07:51.494724Z","end":"2026-06-08T22:07:51.611349Z","steps":["trace[1006942382] 'range keys from in-memory index tree' (duration: 116.316159ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:07:53.321427Z","caller":"traceutil/trace.go:171","msg":"trace[982103179] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"107.816305ms","start":"2026-06-08T22:07:53.213555Z","end":"2026-06-08T22:07:53.321371Z","steps":["trace[982103179] 'process raft request' (duration: 107.633822ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:07:58.980527Z","caller":"traceutil/trace.go:171","msg":"trace[1861632273] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:383; }","duration":"112.617692ms","start":"2026-06-08T22:07:58.867885Z","end":"2026-06-08T22:07:58.980503Z","steps":["trace[1861632273] 'read index received' (duration: 112.424737ms)","trace[1861632273] 'applied index is now lower than readState.Index' (duration: 192.095µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:07:58.98077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.865104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-08T22:07:58.980824Z","caller":"traceutil/trace.go:171","msg":"trace[600839163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:372; }","duration":"112.968163ms","start":"2026-06-08T22:07:58.867839Z","end":"2026-06-08T22:07:58.980807Z","steps":["trace[600839163] 'agreement among raft nodes before linearized reading' (duration: 112.8024ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:07:58.98129Z","caller":"traceutil/trace.go:171","msg":"trace[982267021] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"182.323232ms","start":"2026-06-08T22:07:58.79895Z","end":"2026-06-08T22:07:58.981273Z","steps":["trace[982267021] 'process raft request' (duration: 181.443698ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:07:59.371189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.620536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T22:07:59.371273Z","caller":"traceutil/trace.go:171","msg":"trace[120931267] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"385.566337ms","start":"2026-06-08T22:07:58.985696Z","end":"2026-06-08T22:07:59.371262Z","steps":["trace[120931267] 'process raft request' (duration: 147.546567ms)","trace[120931267] 'compare' (duration: 237.359814ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:07:59.371309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:07:58.985671Z","time spent":"385.620092ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:07:59.378854Z","caller":"traceutil/trace.go:171","msg":"trace[2107957977] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"385.686211ms","start":"2026-06-08T22:07:58.993149Z","end":"2026-06-08T22:07:59.378836Z","steps":["trace[2107957977] 'process raft request' (duration: 385.55297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:07:59.37905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:07:58.993133Z","time spent":"385.828944ms","remote":"127.0.0.1:60848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:08:21.1104Z","caller":"traceutil/trace.go:171","msg":"trace[260222502] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"117.315753ms","start":"2026-06-08T22:08:20.993049Z","end":"2026-06-08T22:08:21.110365Z","steps":["trace[260222502] 'process raft request' (duration: 117.251706ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:21.111036Z","caller":"traceutil/trace.go:171","msg":"trace[2081060419] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"119.491244ms","start":"2026-06-08T22:08:20.991511Z","end":"2026-06-08T22:08:21.111003Z","steps":["trace[2081060419] 'process raft request' (duration: 115.077001ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:21.111185Z","caller":"traceutil/trace.go:171","msg":"trace[682792532] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"119.580874ms","start":"2026-06-08T22:08:20.991562Z","end":"2026-06-08T22:08:21.111143Z","steps":["trace[682792532] 'process raft request' (duration: 118.670388ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:21.113232Z","caller":"traceutil/trace.go:171","msg":"trace[499709708] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"102.179838ms","start":"2026-06-08T22:08:21.01101Z","end":"2026-06-08T22:08:21.11319Z","steps":["trace[499709708] 'process raft request' (duration: 101.982159ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:25.137815Z","caller":"traceutil/trace.go:171","msg":"trace[1407599706] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"145.536435ms","start":"2026-06-08T22:08:24.992242Z","end":"2026-06-08T22:08:25.137779Z","steps":["trace[1407599706] 'process raft request' (duration: 144.636429ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:26.224302Z","caller":"traceutil/trace.go:171","msg":"trace[684906496] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"298.307ms","start":"2026-06-08T22:08:25.925956Z","end":"2026-06-08T22:08:26.224263Z","steps":["trace[684906496] 'process raft request' (duration: 284.52758ms)","trace[684906496] 'compare' (duration: 13.371922ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:08:26.224523Z","caller":"traceutil/trace.go:171","msg":"trace[1243968044] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"298.159928ms","start":"2026-06-08T22:08:25.926328Z","end":"2026-06-08T22:08:26.224488Z","steps":["trace[1243968044] 'process raft request' (duration: 297.832346ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:26.874856Z","caller":"traceutil/trace.go:171","msg":"trace[1311945544] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"146.886896ms","start":"2026-06-08T22:08:26.727941Z","end":"2026-06-08T22:08:26.874828Z","steps":["trace[1311945544] 'process raft request' (duration: 146.232423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:08:27.253217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.38918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:08:27.253337Z","caller":"traceutil/trace.go:171","msg":"trace[871244201] range","detail":"{range_begin:/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:592; }","duration":"214.534683ms","start":"2026-06-08T22:08:27.038772Z","end":"2026-06-08T22:08:27.253307Z","steps":["trace[871244201] 'range keys from in-memory index tree' (duration: 214.348357ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:08:27.253217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.51098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2jjfp\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-08T22:08:27.253472Z","caller":"traceutil/trace.go:171","msg":"trace[983661957] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2jjfp; range_end:; response_count:1; response_revision:592; }","duration":"225.797696ms","start":"2026-06-08T22:08:27.027647Z","end":"2026-06-08T22:08:27.253445Z","steps":["trace[983661957] 'range keys from in-memory index tree' (duration: 225.407679ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:27.851611Z","caller":"traceutil/trace.go:171","msg":"trace[1508996613] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"342.662199ms","start":"2026-06-08T22:08:27.508926Z","end":"2026-06-08T22:08:27.851588Z","steps":["trace[1508996613] 'read index received' (duration: 342.626006ms)","trace[1508996613] 'applied index is now lower than readState.Index' (duration: 34.703µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:08:27.851642Z","caller":"traceutil/trace.go:171","msg":"trace[1996437939] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"580.122418ms","start":"2026-06-08T22:08:27.271494Z","end":"2026-06-08T22:08:27.851616Z","steps":["trace[1996437939] 'process raft request' (duration: 579.93551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:08:27.851816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.86944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-08T22:08:27.851806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:08:27.271477Z","time spent":"580.238788ms","remote":"127.0.0.1:60848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:08:27.851856Z","caller":"traceutil/trace.go:171","msg":"trace[1882243661] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:593; }","duration":"342.967187ms","start":"2026-06-08T22:08:27.508878Z","end":"2026-06-08T22:08:27.851846Z","steps":["trace[1882243661] 'agreement among raft nodes before linearized reading' (duration: 342.820404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:08:27.851891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:08:27.508858Z","time spent":"343.025474ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T22:08:28.168049Z","caller":"traceutil/trace.go:171","msg":"trace[266039922] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"308.504135ms","start":"2026-06-08T22:08:27.859495Z","end":"2026-06-08T22:08:28.167999Z","steps":["trace[266039922] 'process raft request' (duration: 308.361521ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:28.168095Z","caller":"traceutil/trace.go:171","msg":"trace[1071470469] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"488.012518ms","start":"2026-06-08T22:08:27.680004Z","end":"2026-06-08T22:08:28.168017Z","steps":["trace[1071470469] 'process raft request' (duration: 485.377876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:08:28.168268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:08:27.85947Z","time spent":"308.682891ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:08:28.168493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:08:27.679975Z","time spent":"488.252602ms","remote":"127.0.0.1:60750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:08:28.169377Z","caller":"traceutil/trace.go:171","msg":"trace[101851588] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"317.646577ms","start":"2026-06-08T22:08:27.851673Z","end":"2026-06-08T22:08:28.16932Z","steps":["trace[101851588] 'read index received' (duration: 313.042997ms)","trace[101851588] 'applied index is now lower than readState.Index' (duration: 4.60064ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:08:28.172492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.166177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:08:28.172573Z","caller":"traceutil/trace.go:171","msg":"trace[1864573453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"333.268656ms","start":"2026-06-08T22:08:27.839276Z","end":"2026-06-08T22:08:28.172545Z","steps":["trace[1864573453] 'agreement among raft nodes before linearized reading' (duration: 330.162009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:08:28.172633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:08:27.839258Z","time spent":"333.352076ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T22:08:39.69794Z","caller":"traceutil/trace.go:171","msg":"trace[1408029044] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"145.756302ms","start":"2026-06-08T22:08:39.552155Z","end":"2026-06-08T22:08:39.697911Z","steps":["trace[1408029044] 'process raft request' (duration: 144.848303ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:44.560071Z","caller":"traceutil/trace.go:171","msg":"trace[448566547] linearizableReadLoop","detail":"{readStateIndex:789; appliedIndex:788; }","duration":"254.892855ms","start":"2026-06-08T22:08:44.305156Z","end":"2026-06-08T22:08:44.560049Z","steps":["trace[448566547] 'read index received' (duration: 254.712267ms)","trace[448566547] 'applied index is now lower than readState.Index' (duration: 179.798µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:08:44.5604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.524636ms","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-06-08T22:08:44.560416Z","caller":"traceutil/trace.go:171","msg":"trace[1233516909] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"304.111095ms","start":"2026-06-08T22:08:44.256293Z","end":"2026-06-08T22:08:44.560405Z","steps":["trace[1233516909] 'process raft request' (duration: 303.639998ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:44.56044Z","caller":"traceutil/trace.go:171","msg":"trace[1015908416] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:763; }","duration":"248.628216ms","start":"2026-06-08T22:08:44.311803Z","end":"2026-06-08T22:08:44.560432Z","steps":["trace[1015908416] 'agreement among raft nodes before linearized reading' (duration: 248.489642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:08:44.560505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:08:44.256271Z","time spent":"304.174001ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:08:44.560524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.366432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-08T22:08:44.560575Z","caller":"traceutil/trace.go:171","msg":"trace[405199817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:763; }","duration":"255.44759ms","start":"2026-06-08T22:08:44.305112Z","end":"2026-06-08T22:08:44.56056Z","steps":["trace[405199817] 'agreement among raft nodes before linearized reading' (duration: 255.305867ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:44.79049Z","caller":"traceutil/trace.go:171","msg":"trace[1275063470] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"226.502472ms","start":"2026-06-08T22:08:44.56396Z","end":"2026-06-08T22:08:44.790462Z","steps":["trace[1275063470] 'process raft request' (duration: 219.807791ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:08:44.793665Z","caller":"traceutil/trace.go:171","msg":"trace[1066045806] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"229.371004ms","start":"2026-06-08T22:08:44.564273Z","end":"2026-06-08T22:08:44.793644Z","steps":["trace[1066045806] 'process raft request' (duration: 229.056663ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:09:37.228288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.381005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-08T22:09:37.228372Z","caller":"traceutil/trace.go:171","msg":"trace[1715747325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1303; }","duration":"101.512046ms","start":"2026-06-08T22:09:37.126838Z","end":"2026-06-08T22:09:37.22835Z","steps":["trace[1715747325] 'agreement among raft nodes before linearized reading' (duration: 100.812851ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:09:46.770367Z","caller":"traceutil/trace.go:171","msg":"trace[1041721321] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"157.90276ms","start":"2026-06-08T22:09:46.612441Z","end":"2026-06-08T22:09:46.770344Z","steps":["trace[1041721321] 'process raft request' (duration: 157.755047ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:09:53.433521Z","caller":"traceutil/trace.go:171","msg":"trace[1130608821] transaction","detail":"{read_only:false; number_of_response:0; response_revision:1562; }","duration":"100.047558ms","start":"2026-06-08T22:09:53.33344Z","end":"2026-06-08T22:09:53.433487Z","steps":["trace[1130608821] 'process raft request' (duration: 99.928784ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:10.946782Z","caller":"traceutil/trace.go:171","msg":"trace[1109454240] transaction","detail":"{read_only:false; response_revision:1864; number_of_response:1; }","duration":"441.598939ms","start":"2026-06-08T22:10:10.505152Z","end":"2026-06-08T22:10:10.94675Z","steps":["trace[1109454240] 'process raft request' (duration: 441.34646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:10.946991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:10.505134Z","time spent":"441.732496ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":515,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:10:10.947023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.75145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:10:10.947202Z","caller":"traceutil/trace.go:171","msg":"trace[2014451888] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1864; }","duration":"364.03611ms","start":"2026-06-08T22:10:10.58314Z","end":"2026-06-08T22:10:10.947176Z","steps":["trace[2014451888] 'agreement among raft nodes before linearized reading' (duration: 363.705187ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:10.946708Z","caller":"traceutil/trace.go:171","msg":"trace[929819891] linearizableReadLoop","detail":"{readStateIndex:1935; appliedIndex:1934; }","duration":"363.485878ms","start":"2026-06-08T22:10:10.583192Z","end":"2026-06-08T22:10:10.946678Z","steps":["trace[929819891] 'read index received' (duration: 363.354013ms)","trace[929819891] 'applied index is now lower than readState.Index' (duration: 130.745µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:10:10.947383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:10.583117Z","time spent":"364.243648ms","remote":"127.0.0.1:32778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":67,"response size":29,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"info","ts":"2026-06-08T22:10:11.090081Z","caller":"traceutil/trace.go:171","msg":"trace[634539754] linearizableReadLoop","detail":"{readStateIndex:1937; appliedIndex:1935; }","duration":"142.656703ms","start":"2026-06-08T22:10:10.947399Z","end":"2026-06-08T22:10:11.090056Z","steps":["trace[634539754] 'read index received' (duration: 107.278576ms)","trace[634539754] 'applied index is now lower than readState.Index' (duration: 35.377127ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:10:11.090213Z","caller":"traceutil/trace.go:171","msg":"trace[1449654635] transaction","detail":"{read_only:false; response_revision:1866; number_of_response:1; }","duration":"172.248381ms","start":"2026-06-08T22:10:10.917918Z","end":"2026-06-08T22:10:11.090167Z","steps":["trace[1449654635] 'process raft request' (duration: 172.061033ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:11.090275Z","caller":"traceutil/trace.go:171","msg":"trace[796440653] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"236.673515ms","start":"2026-06-08T22:10:10.853572Z","end":"2026-06-08T22:10:11.090245Z","steps":["trace[796440653] 'process raft request' (duration: 201.149333ms)","trace[796440653] 'compare' (duration: 35.080874ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:10:11.090408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.162463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T22:10:11.090435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.365387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-74f249f5-a64b-44d1-b4b7-398c40be0e5c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-08T22:10:11.090509Z","caller":"traceutil/trace.go:171","msg":"trace[1509151156] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-74f249f5-a64b-44d1-b4b7-398c40be0e5c; range_end:; response_count:1; response_revision:1866; }","duration":"489.457901ms","start":"2026-06-08T22:10:10.601034Z","end":"2026-06-08T22:10:11.090491Z","steps":["trace[1509151156] 'agreement among raft nodes before linearized reading' (duration: 489.110846ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:11.09051Z","caller":"traceutil/trace.go:171","msg":"trace[420098396] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1866; }","duration":"314.301079ms","start":"2026-06-08T22:10:10.776182Z","end":"2026-06-08T22:10:11.090483Z","steps":["trace[420098396] 'agreement among raft nodes before linearized reading' (duration: 314.088731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.090549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:10.60097Z","time spent":"489.569005ms","remote":"127.0.0.1:60848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-74f249f5-a64b-44d1-b4b7-398c40be0e5c\" "} {"level":"warn","ts":"2026-06-08T22:10:11.090575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:10.776119Z","time spent":"314.441674ms","remote":"127.0.0.1:35378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-08T22:10:11.090595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.752186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-08T22:10:11.090654Z","caller":"traceutil/trace.go:171","msg":"trace[675120381] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1866; }","duration":"357.85254ms","start":"2026-06-08T22:10:10.732786Z","end":"2026-06-08T22:10:11.090639Z","steps":["trace[675120381] 'agreement among raft nodes before linearized reading' (duration: 357.649842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.090693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:10.732767Z","time spent":"357.917553ms","remote":"127.0.0.1:32950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-08T22:10:11.216144Z","caller":"traceutil/trace.go:171","msg":"trace[592129479] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"118.135278ms","start":"2026-06-08T22:10:11.097987Z","end":"2026-06-08T22:10:11.216122Z","steps":["trace[592129479] 'process raft request' (duration: 118.016263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.578025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.732558ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-08T22:10:11.578337Z","caller":"traceutil/trace.go:171","msg":"trace[1342456200] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"300.878563ms","start":"2026-06-08T22:10:11.27743Z","end":"2026-06-08T22:10:11.578309Z","steps":["trace[1342456200] 'process raft request' (duration: 300.710157ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.57848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:11.277412Z","time spent":"300.990309ms","remote":"127.0.0.1:60836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:10:11.618851Z","caller":"traceutil/trace.go:171","msg":"trace[357867681] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"341.01827ms","start":"2026-06-08T22:10:11.277814Z","end":"2026-06-08T22:10:11.618832Z","steps":["trace[357867681] 'process raft request' (duration: 340.867204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.61899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:11.277789Z","time spent":"341.130664ms","remote":"127.0.0.1:60836","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":977,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:10:11.61929Z","caller":"traceutil/trace.go:171","msg":"trace[1766011533] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"341.389755ms","start":"2026-06-08T22:10:11.277887Z","end":"2026-06-08T22:10:11.619277Z","steps":["trace[1766011533] 'process raft request' (duration: 340.889135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.619405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:11.277862Z","time spent":"341.50585ms","remote":"127.0.0.1:60932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1471,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:10:11.619766Z","caller":"traceutil/trace.go:171","msg":"trace[429425244] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"341.844743ms","start":"2026-06-08T22:10:11.277893Z","end":"2026-06-08T22:10:11.619738Z","steps":["trace[429425244] 'process raft request' (duration: 341.277901ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.619929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:11.277878Z","time spent":"341.955798ms","remote":"127.0.0.1:60932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1529,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:10:11.619934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.215645ms","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":"info","ts":"2026-06-08T22:10:11.619983Z","caller":"traceutil/trace.go:171","msg":"trace[1115928827] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1872; }","duration":"187.287627ms","start":"2026-06-08T22:10:11.432681Z","end":"2026-06-08T22:10:11.619969Z","steps":["trace[1115928827] 'agreement among raft nodes before linearized reading' (duration: 187.215014ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:11.619837Z","caller":"traceutil/trace.go:171","msg":"trace[447152680] linearizableReadLoop","detail":"{readStateIndex:1944; appliedIndex:1942; }","duration":"186.915182ms","start":"2026-06-08T22:10:11.432709Z","end":"2026-06-08T22:10:11.619624Z","steps":["trace[447152680] 'read index received' (duration: 186.063629ms)","trace[447152680] 'applied index is now lower than readState.Index' (duration: 850.673µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:10:11.626566Z","caller":"traceutil/trace.go:171","msg":"trace[83738594] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"184.796299ms","start":"2026-06-08T22:10:11.441761Z","end":"2026-06-08T22:10:11.626557Z","steps":["trace[83738594] 'process raft request' (duration: 184.422814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:11.62668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.720151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-08T22:10:11.626707Z","caller":"traceutil/trace.go:171","msg":"trace[655925881] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1873; }","duration":"157.789385ms","start":"2026-06-08T22:10:11.46891Z","end":"2026-06-08T22:10:11.6267Z","steps":["trace[655925881] 'agreement among raft nodes before linearized reading' (duration: 157.335806ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:23.781126Z","caller":"traceutil/trace.go:171","msg":"trace[1790621463] transaction","detail":"{read_only:false; response_revision:1974; number_of_response:1; }","duration":"101.387864ms","start":"2026-06-08T22:10:23.67969Z","end":"2026-06-08T22:10:23.781078Z","steps":["trace[1790621463] 'process raft request' (duration: 35.201948ms)","trace[1790621463] 'compare' (duration: 65.800288ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:10:26.310902Z","caller":"traceutil/trace.go:171","msg":"trace[2141060565] linearizableReadLoop","detail":"{readStateIndex:2067; appliedIndex:2066; }","duration":"110.137724ms","start":"2026-06-08T22:10:26.200737Z","end":"2026-06-08T22:10:26.310874Z","steps":["trace[2141060565] 'read index received' (duration: 109.904573ms)","trace[2141060565] 'applied index is now lower than readState.Index' (duration: 231.741µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:10:26.311106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.351625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:10:26.311181Z","caller":"traceutil/trace.go:171","msg":"trace[256294892] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1992; }","duration":"110.444409ms","start":"2026-06-08T22:10:26.20072Z","end":"2026-06-08T22:10:26.311164Z","steps":["trace[256294892] 'agreement among raft nodes before linearized reading' (duration: 110.306183ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:27.086047Z","caller":"traceutil/trace.go:171","msg":"trace[1417818507] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"180.973886ms","start":"2026-06-08T22:10:26.90505Z","end":"2026-06-08T22:10:27.086024Z","steps":["trace[1417818507] 'process raft request' (duration: 180.782836ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:27.668548Z","caller":"traceutil/trace.go:171","msg":"trace[193583793] transaction","detail":"{read_only:false; response_revision:2004; number_of_response:1; }","duration":"243.650877ms","start":"2026-06-08T22:10:27.424871Z","end":"2026-06-08T22:10:27.668522Z","steps":["trace[193583793] 'process raft request' (duration: 243.468379ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:31.955333Z","caller":"traceutil/trace.go:171","msg":"trace[1948099929] transaction","detail":"{read_only:false; response_revision:2029; number_of_response:1; }","duration":"113.580994ms","start":"2026-06-08T22:10:31.841706Z","end":"2026-06-08T22:10:31.955287Z","steps":["trace[1948099929] 'process raft request' (duration: 55.257389ms)","trace[1948099929] 'compare' (duration: 57.604708ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:10:31.955638Z","caller":"traceutil/trace.go:171","msg":"trace[1017810489] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"113.798855ms","start":"2026-06-08T22:10:31.841809Z","end":"2026-06-08T22:10:31.955608Z","steps":["trace[1017810489] 'process raft request' (duration: 113.362943ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:31.956022Z","caller":"traceutil/trace.go:171","msg":"trace[1696826426] transaction","detail":"{read_only:false; response_revision:2031; number_of_response:1; }","duration":"113.136411ms","start":"2026-06-08T22:10:31.84287Z","end":"2026-06-08T22:10:31.956006Z","steps":["trace[1696826426] 'process raft request' (duration: 112.674637ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:49.934415Z","caller":"traceutil/trace.go:171","msg":"trace[1535351523] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"150.825191ms","start":"2026-06-08T22:10:49.783569Z","end":"2026-06-08T22:10:49.934394Z","steps":["trace[1535351523] 'process raft request' (duration: 150.590247ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:50.357589Z","caller":"traceutil/trace.go:171","msg":"trace[133816912] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"168.701651ms","start":"2026-06-08T22:10:50.188616Z","end":"2026-06-08T22:10:50.357318Z","steps":["trace[133816912] 'process raft request' (duration: 125.047559ms)","trace[133816912] 'compare' (duration: 43.231807ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:10:50.708315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.215687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-08T22:10:50.708418Z","caller":"traceutil/trace.go:171","msg":"trace[1435907857] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2134; }","duration":"238.350654ms","start":"2026-06-08T22:10:50.470028Z","end":"2026-06-08T22:10:50.708378Z","steps":["trace[1435907857] 'range keys from in-memory index tree' (duration: 237.94145ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:50.708613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.150359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-08T22:10:50.709194Z","caller":"traceutil/trace.go:171","msg":"trace[1014814361] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2134; }","duration":"163.781067ms","start":"2026-06-08T22:10:50.545321Z","end":"2026-06-08T22:10:50.709102Z","steps":["trace[1014814361] 'range keys from in-memory index tree' (duration: 162.972408ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:50.919236Z","caller":"traceutil/trace.go:171","msg":"trace[807845906] transaction","detail":"{read_only:false; response_revision:2135; number_of_response:1; }","duration":"205.163331ms","start":"2026-06-08T22:10:50.714042Z","end":"2026-06-08T22:10:50.919206Z","steps":["trace[807845906] 'process raft request' (duration: 205.035234ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:51.472781Z","caller":"traceutil/trace.go:171","msg":"trace[342354082] transaction","detail":"{read_only:false; response_revision:2136; number_of_response:1; }","duration":"227.190139ms","start":"2026-06-08T22:10:51.24557Z","end":"2026-06-08T22:10:51.47276Z","steps":["trace[342354082] 'process raft request' (duration: 227.060241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:53.004604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.236239277s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-08T22:10:53.004888Z","caller":"traceutil/trace.go:171","msg":"trace[54010991] linearizableReadLoop","detail":"{readStateIndex:2217; appliedIndex:2215; }","duration":"1.581336652s","start":"2026-06-08T22:10:51.423529Z","end":"2026-06-08T22:10:53.004865Z","steps":["trace[54010991] 'read index received' (duration: 49.123868ms)","trace[54010991] 'applied index is now lower than readState.Index' (duration: 1.532211444s)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:10:53.005042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.581496503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:10:53.005085Z","caller":"traceutil/trace.go:171","msg":"trace[1186313560] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:2136; }","duration":"1.581612359s","start":"2026-06-08T22:10:51.423459Z","end":"2026-06-08T22:10:53.005072Z","steps":["trace[1186313560] 'agreement among raft nodes before linearized reading' (duration: 1.581524743s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:53.005128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.423439Z","time spent":"1.581677814s","remote":"127.0.0.1:60902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":27,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"info","ts":"2026-06-08T22:10:53.00547Z","caller":"traceutil/trace.go:171","msg":"trace[2047185258] transaction","detail":"{read_only:false; response_revision:2137; number_of_response:1; }","duration":"1.064129468s","start":"2026-06-08T22:10:51.941321Z","end":"2026-06-08T22:10:53.005451Z","steps":["trace[2047185258] 'process raft request' (duration: 1.063409913s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:53.005594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.941297Z","time spent":"1.064221893s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:10:53.840496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999991213s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-08T22:10:53.840583Z","caller":"traceutil/trace.go:171","msg":"trace[2067208392] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000131071s","start":"2026-06-08T22:10:51.840432Z","end":"2026-06-08T22:10:53.840563Z","steps":["trace[2067208392] 'agreement among raft nodes before linearized reading' (duration: 2.000022515s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:53.840632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.840404Z","time spent":"2.000219457s","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/08 22:10:53 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-08T22:10:54.433477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.146656ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:10:54.434353Z","caller":"traceutil/trace.go:171","msg":"trace[1487429538] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2137; }","duration":"623.02882ms","start":"2026-06-08T22:10:53.811303Z","end":"2026-06-08T22:10:54.434332Z","steps":["trace[1487429538] 'range keys from in-memory index tree' (duration: 622.131325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.434027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.428495303s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T22:10:54.434575Z","caller":"traceutil/trace.go:171","msg":"trace[114205415] transaction","detail":"{read_only:false; response_revision:2138; number_of_response:1; }","duration":"2.485308429s","start":"2026-06-08T22:10:51.949252Z","end":"2026-06-08T22:10:54.434561Z","steps":["trace[114205415] 'process raft request' (duration: 1.056186468s)","trace[114205415] 'compare' (duration: 1.427757306s)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:10:54.434672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.949228Z","time spent":"2.485381904s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:10:54.434699Z","caller":"traceutil/trace.go:171","msg":"trace[716596242] transaction","detail":"{read_only:false; response_revision:2140; number_of_response:1; }","duration":"2.387038654s","start":"2026-06-08T22:10:52.047643Z","end":"2026-06-08T22:10:54.434682Z","steps":["trace[716596242] 'process raft request' (duration: 2.386934618s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.434922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.71915687s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-06-08T22:10:54.434952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.370307437s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-08T22:10:54.435051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.388893008s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-08T22:10:54.434992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.045612535s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-08T22:10:54.435054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.047618Z","time spent":"2.387179653s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:10:54.435126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.332416333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-08T22:10:54.435079Z","caller":"traceutil/trace.go:171","msg":"trace[1775277835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2141; }","duration":"2.370436695s","start":"2026-06-08T22:10:52.064603Z","end":"2026-06-08T22:10:54.43504Z","steps":["trace[1775277835] 'agreement among raft nodes before linearized reading' (duration: 2.3702063s)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:54.435084Z","caller":"traceutil/trace.go:171","msg":"trace[808383103] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2141; }","duration":"2.388962471s","start":"2026-06-08T22:10:52.046113Z","end":"2026-06-08T22:10:54.435075Z","steps":["trace[808383103] 'agreement among raft nodes before linearized reading' (duration: 2.388872066s)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:54.435166Z","caller":"traceutil/trace.go:171","msg":"trace[2104748797] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2141; }","duration":"2.332486568s","start":"2026-06-08T22:10:52.102668Z","end":"2026-06-08T22:10:54.435154Z","steps":["trace[2104748797] 'agreement among raft nodes before linearized reading' (duration: 2.332356309s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.435164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.46395937s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-08T22:10:54.435196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.102655Z","time spent":"2.332535431s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":576,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-08T22:10:54.435199Z","caller":"traceutil/trace.go:171","msg":"trace[1041446384] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2141; }","duration":"2.464022054s","start":"2026-06-08T22:10:51.97117Z","end":"2026-06-08T22:10:54.435192Z","steps":["trace[1041446384] 'agreement among raft nodes before linearized reading' (duration: 2.463933408s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.435201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.453788226s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-06-08T22:10:54.435256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.971158Z","time spent":"2.464089768s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-08T22:10:54.434714Z","caller":"traceutil/trace.go:171","msg":"trace[372092064] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"956.08761ms","start":"2026-06-08T22:10:53.478608Z","end":"2026-06-08T22:10:54.434695Z","steps":["trace[372092064] 'process raft request' (duration: 956.027607ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:54.4353Z","caller":"traceutil/trace.go:171","msg":"trace[1820994573] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2141; }","duration":"2.453921473s","start":"2026-06-08T22:10:51.981362Z","end":"2026-06-08T22:10:54.435283Z","steps":["trace[1820994573] 'agreement among raft nodes before linearized reading' (duration: 2.453666698s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.435313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511880754s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-08T22:10:54.435338Z","caller":"traceutil/trace.go:171","msg":"trace[853834610] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2141; }","duration":"1.511939697s","start":"2026-06-08T22:10:52.923391Z","end":"2026-06-08T22:10:54.43533Z","steps":["trace[853834610] 'agreement among raft nodes before linearized reading' (duration: 1.511871113s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.435346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.981352Z","time spent":"2.453984736s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-08T22:10:54.435362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.923372Z","time spent":"1.51198409s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T22:10:54.435375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:53.478583Z","time spent":"956.760491ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:10:54.435401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.064592Z","time spent":"2.370703941s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-08T22:10:54.435424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.391005376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:10:54.435442Z","caller":"traceutil/trace.go:171","msg":"trace[2079251] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:2141; }","duration":"2.39109052s","start":"2026-06-08T22:10:52.044344Z","end":"2026-06-08T22:10:54.435435Z","steps":["trace[2079251] 'agreement among raft nodes before linearized reading' (duration: 2.391060879s)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:54.434671Z","caller":"traceutil/trace.go:171","msg":"trace[2038239399] transaction","detail":"{read_only:false; response_revision:2139; number_of_response:1; }","duration":"2.480853129s","start":"2026-06-08T22:10:51.953799Z","end":"2026-06-08T22:10:54.434652Z","steps":["trace[2038239399] 'process raft request' (duration: 2.480688259s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.435461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.044302Z","time spent":"2.391154174s","remote":"127.0.0.1:46282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-06-08T22:10:54.435488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.046085Z","time spent":"2.389384938s","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-08T22:10:54.435506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.953756Z","time spent":"2.481707443s","remote":"127.0.0.1:60840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8538,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:10:54.43551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.355671808s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:10:54.435542Z","caller":"traceutil/trace.go:171","msg":"trace[708128746] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2141; }","duration":"2.355746001s","start":"2026-06-08T22:10:52.079787Z","end":"2026-06-08T22:10:54.435533Z","steps":["trace[708128746] 'agreement among raft nodes before linearized reading' (duration: 2.355686138s)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:54.435128Z","caller":"traceutil/trace.go:171","msg":"trace[1007745284] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:2141; }","duration":"2.045789165s","start":"2026-06-08T22:10:52.389322Z","end":"2026-06-08T22:10:54.435111Z","steps":["trace[1007745284] 'agreement among raft nodes before linearized reading' (duration: 2.045620276s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.435578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.079767Z","time spent":"2.355803866s","remote":"127.0.0.1:32856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"info","ts":"2026-06-08T22:10:54.434964Z","caller":"traceutil/trace.go:171","msg":"trace[111025912] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2141; }","duration":"2.719239266s","start":"2026-06-08T22:10:51.715715Z","end":"2026-06-08T22:10:54.434954Z","steps":["trace[111025912] 'agreement among raft nodes before linearized reading' (duration: 2.719063175s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.435655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:51.715694Z","time spent":"2.719953389s","remote":"127.0.0.1:32950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5434,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-08T22:10:54.435649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:52.3893Z","time spent":"2.046336699s","remote":"127.0.0.1:32888","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":11,"response size":29,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-06-08T22:10:54.434758Z","caller":"traceutil/trace.go:171","msg":"trace[2096189617] linearizableReadLoop","detail":"{readStateIndex:2221; appliedIndex:2218; }","duration":"1.429814593s","start":"2026-06-08T22:10:53.004934Z","end":"2026-06-08T22:10:54.434748Z","steps":["trace[2096189617] 'read index received' (duration: 94.549052ms)","trace[2096189617] 'applied index is now lower than readState.Index' (duration: 1.335264771s)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:10:54.435941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.368196075s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:10:54.435989Z","caller":"traceutil/trace.go:171","msg":"trace[1457735086] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2141; }","duration":"1.36828176s","start":"2026-06-08T22:10:53.067696Z","end":"2026-06-08T22:10:54.435978Z","steps":["trace[1457735086] 'agreement among raft nodes before linearized reading' (duration: 1.368209956s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.436032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:53.067671Z","time spent":"1.368350206s","remote":"127.0.0.1:60954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-08T22:10:54.436218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.8951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:10:54.436259Z","caller":"traceutil/trace.go:171","msg":"trace[1054108256] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2141; }","duration":"129.973686ms","start":"2026-06-08T22:10:54.306274Z","end":"2026-06-08T22:10:54.436247Z","steps":["trace[1054108256] 'agreement among raft nodes before linearized reading' (duration: 129.913512ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.436435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.010453406s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:10:54.436465Z","caller":"traceutil/trace.go:171","msg":"trace[1525455573] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2141; }","duration":"1.010524851s","start":"2026-06-08T22:10:53.425931Z","end":"2026-06-08T22:10:54.436456Z","steps":["trace[1525455573] 'agreement among raft nodes before linearized reading' (duration: 1.010475187s)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.436487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.709492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12382"} {"level":"info","ts":"2026-06-08T22:10:54.436542Z","caller":"traceutil/trace.go:171","msg":"trace[1374513321] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2141; }","duration":"282.802867ms","start":"2026-06-08T22:10:54.15373Z","end":"2026-06-08T22:10:54.436533Z","steps":["trace[1374513321] 'agreement among raft nodes before linearized reading' (duration: 282.643077ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.436623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"595.708099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T22:10:54.436688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.076778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b73aa076f26ba5\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-06-08T22:10:54.436688Z","caller":"traceutil/trace.go:171","msg":"trace[230950356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2141; }","duration":"595.830397ms","start":"2026-06-08T22:10:53.840839Z","end":"2026-06-08T22:10:54.43667Z","steps":["trace[230950356] 'agreement among raft nodes before linearized reading' (duration: 595.745961ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:10:54.436715Z","caller":"traceutil/trace.go:171","msg":"trace[532756677] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18b73aa076f26ba5; range_end:; response_count:1; response_revision:2141; }","duration":"920.137603ms","start":"2026-06-08T22:10:53.51657Z","end":"2026-06-08T22:10:54.436707Z","steps":["trace[532756677] 'agreement among raft nodes before linearized reading' (duration: 920.056597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:10:54.436735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:53.516552Z","time spent":"920.178904ms","remote":"127.0.0.1:60728","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":868,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18b73aa076f26ba5\" "} {"level":"warn","ts":"2026-06-08T22:10:54.43673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:53.840808Z","time spent":"595.909471ms","remote":"127.0.0.1:60622","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T22:10:54.436486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:10:53.425911Z","time spent":"1.010569873s","remote":"127.0.0.1:32808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":29,"request content":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true "} {"level":"info","ts":"2026-06-08T22:11:39.028825Z","caller":"traceutil/trace.go:171","msg":"trace[1734029512] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"119.726974ms","start":"2026-06-08T22:11:38.90906Z","end":"2026-06-08T22:11:39.028787Z","steps":["trace[1734029512] 'process raft request' (duration: 115.235076ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:11:39.050981Z","caller":"traceutil/trace.go:171","msg":"trace[389831195] transaction","detail":"{read_only:false; response_revision:2454; number_of_response:1; }","duration":"141.648552ms","start":"2026-06-08T22:11:38.90931Z","end":"2026-06-08T22:11:39.050959Z","steps":["trace[389831195] 'process raft request' (duration: 141.465849ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:11:39.051302Z","caller":"traceutil/trace.go:171","msg":"trace[1294289989] transaction","detail":"{read_only:false; response_revision:2455; number_of_response:1; }","duration":"141.865529ms","start":"2026-06-08T22:11:38.909413Z","end":"2026-06-08T22:11:39.051278Z","steps":["trace[1294289989] 'process raft request' (duration: 141.47721ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:11:39.051447Z","caller":"traceutil/trace.go:171","msg":"trace[478726981] transaction","detail":"{read_only:false; response_revision:2456; number_of_response:1; }","duration":"142.02155ms","start":"2026-06-08T22:11:38.909411Z","end":"2026-06-08T22:11:39.051432Z","steps":["trace[478726981] 'process raft request' (duration: 141.730529ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:11:39.051636Z","caller":"traceutil/trace.go:171","msg":"trace[1595211265] transaction","detail":"{read_only:false; response_revision:2457; number_of_response:1; }","duration":"142.189832ms","start":"2026-06-08T22:11:38.90942Z","end":"2026-06-08T22:11:39.05161Z","steps":["trace[1595211265] 'process raft request' (duration: 141.867548ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:11:40.084572Z","caller":"traceutil/trace.go:171","msg":"trace[180800195] linearizableReadLoop","detail":"{readStateIndex:2576; appliedIndex:2575; }","duration":"100.5986ms","start":"2026-06-08T22:11:39.983951Z","end":"2026-06-08T22:11:40.08455Z","steps":["trace[180800195] 'read index received' (duration: 59.645756ms)","trace[180800195] 'applied index is now lower than readState.Index' (duration: 40.951904ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:11:40.084844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.87538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-06-08T22:11:40.084885Z","caller":"traceutil/trace.go:171","msg":"trace[745969492] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2485; }","duration":"100.951066ms","start":"2026-06-08T22:11:39.983924Z","end":"2026-06-08T22:11:40.084875Z","steps":["trace[745969492] 'agreement among raft nodes before linearized reading' (duration: 100.711878ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:11:40.085218Z","caller":"traceutil/trace.go:171","msg":"trace[1071648236] transaction","detail":"{read_only:false; response_revision:2485; number_of_response:1; }","duration":"102.949241ms","start":"2026-06-08T22:11:39.981664Z","end":"2026-06-08T22:11:40.084613Z","steps":["trace[1071648236] 'process raft request' (duration: 61.915211ms)","trace[1071648236] 'compare' (duration: 40.853337ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:12:19.397395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.842451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-08T22:12:19.39744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.267961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-08T22:12:19.397483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.817442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-08T22:12:19.39751Z","caller":"traceutil/trace.go:171","msg":"trace[1539238997] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2708; }","duration":"110.361288ms","start":"2026-06-08T22:12:19.287132Z","end":"2026-06-08T22:12:19.397493Z","steps":["trace[1539238997] 'range keys from in-memory index tree' (duration: 110.159362ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:12:19.397536Z","caller":"traceutil/trace.go:171","msg":"trace[969805017] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2708; }","duration":"106.871237ms","start":"2026-06-08T22:12:19.29065Z","end":"2026-06-08T22:12:19.397522Z","steps":["trace[969805017] 'range keys from in-memory index tree' (duration: 106.713083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:12:19.397424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.889549ms","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-06-08T22:12:19.397649Z","caller":"traceutil/trace.go:171","msg":"trace[641364454] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2708; }","duration":"111.146119ms","start":"2026-06-08T22:12:19.286487Z","end":"2026-06-08T22:12:19.397633Z","steps":["trace[641364454] 'range keys from in-memory index tree' (duration: 110.794222ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:12:19.397478Z","caller":"traceutil/trace.go:171","msg":"trace[85250069] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2708; }","duration":"165.968802ms","start":"2026-06-08T22:12:19.231492Z","end":"2026-06-08T22:12:19.397461Z","steps":["trace[85250069] 'range keys from in-memory index tree' (duration: 165.687829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:12:19.397926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.148821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-06-08T22:12:19.399929Z","caller":"traceutil/trace.go:171","msg":"trace[1711239200] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2708; }","duration":"121.280862ms","start":"2026-06-08T22:12:19.276717Z","end":"2026-06-08T22:12:19.397997Z","steps":["trace[1711239200] 'range keys from in-memory index tree' (duration: 120.375181ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:12:19.684654Z","caller":"traceutil/trace.go:171","msg":"trace[368181821] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"282.602709ms","start":"2026-06-08T22:12:19.401997Z","end":"2026-06-08T22:12:19.684599Z","steps":["trace[368181821] 'process raft request' (duration: 243.392027ms)","trace[368181821] 'compare' (duration: 39.082302ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:12:19.6852Z","caller":"traceutil/trace.go:171","msg":"trace[169866768] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"279.507248ms","start":"2026-06-08T22:12:19.405664Z","end":"2026-06-08T22:12:19.685171Z","steps":["trace[169866768] 'process raft request' (duration: 279.448964ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:12:19.685516Z","caller":"traceutil/trace.go:171","msg":"trace[625707356] transaction","detail":"{read_only:false; response_revision:2711; number_of_response:1; }","duration":"281.757254ms","start":"2026-06-08T22:12:19.403742Z","end":"2026-06-08T22:12:19.685499Z","steps":["trace[625707356] 'process raft request' (duration: 281.126325ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:12:19.685655Z","caller":"traceutil/trace.go:171","msg":"trace[1676434610] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"281.825389ms","start":"2026-06-08T22:12:19.403809Z","end":"2026-06-08T22:12:19.685634Z","steps":["trace[1676434610] 'process raft request' (duration: 281.251504ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:12:19.685654Z","caller":"traceutil/trace.go:171","msg":"trace[636161650] transaction","detail":"{read_only:false; response_revision:2712; number_of_response:1; }","duration":"282.062138ms","start":"2026-06-08T22:12:19.403563Z","end":"2026-06-08T22:12:19.685625Z","steps":["trace[636161650] 'process raft request' (duration: 281.447059ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:15:49.077048Z","caller":"traceutil/trace.go:171","msg":"trace[362029305] transaction","detail":"{read_only:false; response_revision:4290; number_of_response:1; }","duration":"127.620822ms","start":"2026-06-08T22:15:48.94939Z","end":"2026-06-08T22:15:49.077011Z","steps":["trace[362029305] 'process raft request' (duration: 69.237836ms)","trace[362029305] 'compare' (duration: 58.164048ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:15:49.077099Z","caller":"traceutil/trace.go:171","msg":"trace[1161960164] transaction","detail":"{read_only:false; response_revision:4291; number_of_response:1; }","duration":"122.079867ms","start":"2026-06-08T22:15:48.954989Z","end":"2026-06-08T22:15:49.077069Z","steps":["trace[1161960164] 'process raft request' (duration: 121.955082ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:15:49.077493Z","caller":"traceutil/trace.go:171","msg":"trace[188687985] transaction","detail":"{read_only:false; response_revision:4292; number_of_response:1; }","duration":"111.674569ms","start":"2026-06-08T22:15:48.96579Z","end":"2026-06-08T22:15:49.077464Z","steps":["trace[188687985] 'process raft request' (duration: 111.199742ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:15:57.610382Z","caller":"traceutil/trace.go:171","msg":"trace[48440238] linearizableReadLoop","detail":"{readStateIndex:4730; appliedIndex:4729; }","duration":"155.398961ms","start":"2026-06-08T22:15:57.454957Z","end":"2026-06-08T22:15:57.610356Z","steps":["trace[48440238] 'read index received' (duration: 108.842771ms)","trace[48440238] 'applied index is now lower than readState.Index' (duration: 46.54537ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:15:57.610672Z","caller":"traceutil/trace.go:171","msg":"trace[957186389] transaction","detail":"{read_only:false; response_revision:4559; number_of_response:1; }","duration":"156.628778ms","start":"2026-06-08T22:15:57.454026Z","end":"2026-06-08T22:15:57.610655Z","steps":["trace[957186389] 'process raft request' (duration: 109.839699ms)","trace[957186389] 'compare' (duration: 46.348663ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:15:57.610863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.881009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-06-08T22:15:57.610949Z","caller":"traceutil/trace.go:171","msg":"trace[1691681185] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4559; }","duration":"155.989803ms","start":"2026-06-08T22:15:57.454939Z","end":"2026-06-08T22:15:57.610929Z","steps":["trace[1691681185] 'agreement among raft nodes before linearized reading' (duration: 155.743734ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:15:57.856825Z","caller":"traceutil/trace.go:171","msg":"trace[1459843467] linearizableReadLoop","detail":"{readStateIndex:4735; appliedIndex:4734; }","duration":"153.880704ms","start":"2026-06-08T22:15:57.702916Z","end":"2026-06-08T22:15:57.856796Z","steps":["trace[1459843467] 'read index received' (duration: 127.69926ms)","trace[1459843467] 'applied index is now lower than readState.Index' (duration: 26.180064ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:15:57.856929Z","caller":"traceutil/trace.go:171","msg":"trace[62906527] transaction","detail":"{read_only:false; response_revision:4564; number_of_response:1; }","duration":"177.421139ms","start":"2026-06-08T22:15:57.679469Z","end":"2026-06-08T22:15:57.85689Z","steps":["trace[62906527] 'process raft request' (duration: 151.178652ms)","trace[62906527] 'compare' (duration: 26.014219ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:15:57.857129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.155234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-06-08T22:15:57.8572Z","caller":"traceutil/trace.go:171","msg":"trace[1157023195] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4564; }","duration":"154.276019ms","start":"2026-06-08T22:15:57.702908Z","end":"2026-06-08T22:15:57.857184Z","steps":["trace[1157023195] 'agreement among raft nodes before linearized reading' (duration: 154.088152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:15:57.857339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.396944ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1821"} {"level":"info","ts":"2026-06-08T22:15:57.85742Z","caller":"traceutil/trace.go:171","msg":"trace[1410517754] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4564; }","duration":"154.496058ms","start":"2026-06-08T22:15:57.702909Z","end":"2026-06-08T22:15:57.857405Z","steps":["trace[1410517754] 'agreement among raft nodes before linearized reading' (duration: 154.052801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:15:57.857569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.587781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60493"} {"level":"info","ts":"2026-06-08T22:15:57.857642Z","caller":"traceutil/trace.go:171","msg":"trace[2120287642] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4564; }","duration":"154.699486ms","start":"2026-06-08T22:15:57.702924Z","end":"2026-06-08T22:15:57.857623Z","steps":["trace[2120287642] 'agreement among raft nodes before linearized reading' (duration: 154.428595ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:15:58.871559Z","caller":"traceutil/trace.go:171","msg":"trace[1956580696] transaction","detail":"{read_only:false; response_revision:4573; number_of_response:1; }","duration":"167.555919ms","start":"2026-06-08T22:15:58.703964Z","end":"2026-06-08T22:15:58.87152Z","steps":["trace[1956580696] 'process raft request' (duration: 167.250057ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:15:58.871558Z","caller":"traceutil/trace.go:171","msg":"trace[1881784431] linearizableReadLoop","detail":"{readStateIndex:4744; appliedIndex:4743; }","duration":"105.372157ms","start":"2026-06-08T22:15:58.766065Z","end":"2026-06-08T22:15:58.871438Z","steps":["trace[1881784431] 'read index received' (duration: 105.056496ms)","trace[1881784431] 'applied index is now lower than readState.Index' (duration: 312.921µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:15:58.871723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.626717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:15:58.871818Z","caller":"traceutil/trace.go:171","msg":"trace[2038588699] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:4573; }","duration":"105.727131ms","start":"2026-06-08T22:15:58.766055Z","end":"2026-06-08T22:15:58.871782Z","steps":["trace[2038588699] 'agreement among raft nodes before linearized reading' (duration: 105.559284ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:04.532979Z","caller":"traceutil/trace.go:171","msg":"trace[1498905035] linearizableReadLoop","detail":"{readStateIndex:4791; appliedIndex:4790; }","duration":"217.227221ms","start":"2026-06-08T22:16:04.315681Z","end":"2026-06-08T22:16:04.532908Z","steps":["trace[1498905035] 'read index received' (duration: 140.880184ms)","trace[1498905035] 'applied index is now lower than readState.Index' (duration: 76.345177ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:16:04.533014Z","caller":"traceutil/trace.go:171","msg":"trace[100664459] transaction","detail":"{read_only:false; response_revision:4618; number_of_response:1; }","duration":"240.751594ms","start":"2026-06-08T22:16:04.292224Z","end":"2026-06-08T22:16:04.532975Z","steps":["trace[100664459] 'process raft request' (duration: 164.274181ms)","trace[100664459] 'compare' (duration: 76.166501ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:04.533161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.450959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:16:04.533259Z","caller":"traceutil/trace.go:171","msg":"trace[928256834] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:4618; }","duration":"217.598867ms","start":"2026-06-08T22:16:04.315637Z","end":"2026-06-08T22:16:04.533236Z","steps":["trace[928256834] 'agreement among raft nodes before linearized reading' (duration: 217.396059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.497916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.19401ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T22:16:05.498035Z","caller":"traceutil/trace.go:171","msg":"trace[980349639] linearizableReadLoop","detail":"{readStateIndex:4792; appliedIndex:4791; }","duration":"666.745099ms","start":"2026-06-08T22:16:04.831273Z","end":"2026-06-08T22:16:05.498018Z","steps":["trace[980349639] 'read index received' (duration: 54.682µs)","trace[980349639] 'applied index is now lower than readState.Index' (duration: 666.687907ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:16:05.498092Z","caller":"traceutil/trace.go:171","msg":"trace[2117429969] transaction","detail":"{read_only:false; response_revision:4619; number_of_response:1; }","duration":"959.832468ms","start":"2026-06-08T22:16:04.53822Z","end":"2026-06-08T22:16:05.498052Z","steps":["trace[2117429969] 'process raft request' (duration: 146.406889ms)","trace[2117429969] 'compare' (duration: 812.972411ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:05.498161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.939706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:16:05.498192Z","caller":"traceutil/trace.go:171","msg":"trace[217522447] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:4619; }","duration":"667.007068ms","start":"2026-06-08T22:16:04.831175Z","end":"2026-06-08T22:16:05.498182Z","steps":["trace[217522447] 'agreement among raft nodes before linearized reading' (duration: 666.912445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.498226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:04.831155Z","time spent":"667.061941ms","remote":"127.0.0.1:41768","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-06-08T22:16:05.498263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:04.538203Z","time spent":"959.958732ms","remote":"127.0.0.1:60728","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":880,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-08T22:16:05.50175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.974953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:16:05.501829Z","caller":"traceutil/trace.go:171","msg":"trace[651241802] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4620; }","duration":"435.103949ms","start":"2026-06-08T22:16:05.066711Z","end":"2026-06-08T22:16:05.501815Z","steps":["trace[651241802] 'agreement among raft nodes before linearized reading' (duration: 434.990285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.501819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.216322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-08T22:16:05.501835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.972063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-08T22:16:05.501862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:05.066686Z","time spent":"435.169142ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-08T22:16:05.501894Z","caller":"traceutil/trace.go:171","msg":"trace[1570561287] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:4620; }","duration":"436.073617ms","start":"2026-06-08T22:16:05.065807Z","end":"2026-06-08T22:16:05.50188Z","steps":["trace[1570561287] 'agreement among raft nodes before linearized reading' (duration: 435.961833ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:05.501928Z","caller":"traceutil/trace.go:171","msg":"trace[476299785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4620; }","duration":"592.346278ms","start":"2026-06-08T22:16:04.909526Z","end":"2026-06-08T22:16:05.501872Z","steps":["trace[476299785] 'agreement among raft nodes before linearized reading' (duration: 592.14205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.501979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:05.065776Z","time spent":"436.1554ms","remote":"127.0.0.1:60970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-08T22:16:05.501957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.74698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-06-08T22:16:05.501996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"579.934431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-08T22:16:05.502059Z","caller":"traceutil/trace.go:171","msg":"trace[568291130] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4620; }","duration":"583.884685ms","start":"2026-06-08T22:16:04.91815Z","end":"2026-06-08T22:16:05.502035Z","steps":["trace[568291130] 'agreement among raft nodes before linearized reading' (duration: 583.599214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.502129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:04.918141Z","time spent":"583.972839ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":578,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-06-08T22:16:05.502197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.308312ms","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-06-08T22:16:05.502244Z","caller":"traceutil/trace.go:171","msg":"trace[1026489898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4620; }","duration":"584.426458ms","start":"2026-06-08T22:16:04.917806Z","end":"2026-06-08T22:16:05.502232Z","steps":["trace[1026489898] 'agreement among raft nodes before linearized reading' (duration: 584.22546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.502319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.474831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12974"} {"level":"warn","ts":"2026-06-08T22:16:05.502305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:04.917771Z","time spent":"584.524092ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-08T22:16:05.502059Z","caller":"traceutil/trace.go:171","msg":"trace[1592471146] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4620; }","duration":"580.021243ms","start":"2026-06-08T22:16:04.922024Z","end":"2026-06-08T22:16:05.502045Z","steps":["trace[1592471146] 'agreement among raft nodes before linearized reading' (duration: 579.860097ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:05.502409Z","caller":"traceutil/trace.go:171","msg":"trace[1268659695] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4620; }","duration":"200.604594ms","start":"2026-06-08T22:16:05.301785Z","end":"2026-06-08T22:16:05.502389Z","steps":["trace[1268659695] 'agreement among raft nodes before linearized reading' (duration: 200.307333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.50251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.818983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T22:16:05.502552Z","caller":"traceutil/trace.go:171","msg":"trace[1184555496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4620; }","duration":"584.897906ms","start":"2026-06-08T22:16:04.917641Z","end":"2026-06-08T22:16:05.502539Z","steps":["trace[1184555496] 'agreement among raft nodes before linearized reading' (duration: 584.633215ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.502593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:04.917618Z","time spent":"584.968187ms","remote":"127.0.0.1:60920","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-06-08T22:16:05.502541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:04.92201Z","time spent":"580.514174ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-08T22:16:05.502003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:04.909507Z","time spent":"592.457763ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-08T22:16:05.50273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.692164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-08T22:16:05.502766Z","caller":"traceutil/trace.go:171","msg":"trace[863421654] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4620; }","duration":"108.730625ms","start":"2026-06-08T22:16:05.394024Z","end":"2026-06-08T22:16:05.502755Z","steps":["trace[863421654] 'agreement among raft nodes before linearized reading' (duration: 108.637652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:05.502871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.903309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:16:05.502944Z","caller":"traceutil/trace.go:171","msg":"trace[1236016105] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:4620; }","duration":"154.089258ms","start":"2026-06-08T22:16:05.348842Z","end":"2026-06-08T22:16:05.502931Z","steps":["trace[1236016105] 'agreement among raft nodes before linearized reading' (duration: 153.967282ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:05.6408Z","caller":"traceutil/trace.go:171","msg":"trace[1997504305] transaction","detail":"{read_only:false; response_revision:4622; number_of_response:1; }","duration":"132.331187ms","start":"2026-06-08T22:16:05.508444Z","end":"2026-06-08T22:16:05.640776Z","steps":["trace[1997504305] 'process raft request' (duration: 131.820978ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:05.640983Z","caller":"traceutil/trace.go:171","msg":"trace[1447229078] transaction","detail":"{read_only:false; response_revision:4623; number_of_response:1; }","duration":"132.472773ms","start":"2026-06-08T22:16:05.508488Z","end":"2026-06-08T22:16:05.640961Z","steps":["trace[1447229078] 'process raft request' (duration: 131.909451ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:05.641195Z","caller":"traceutil/trace.go:171","msg":"trace[495497165] transaction","detail":"{read_only:false; response_revision:4624; number_of_response:1; }","duration":"132.203992ms","start":"2026-06-08T22:16:05.508981Z","end":"2026-06-08T22:16:05.641185Z","steps":["trace[495497165] 'process raft request' (duration: 131.454643ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:05.641534Z","caller":"traceutil/trace.go:171","msg":"trace[1285756084] transaction","detail":"{read_only:false; response_revision:4626; number_of_response:1; }","duration":"128.476076ms","start":"2026-06-08T22:16:05.513046Z","end":"2026-06-08T22:16:05.641523Z","steps":["trace[1285756084] 'process raft request' (duration: 128.422764ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:05.641559Z","caller":"traceutil/trace.go:171","msg":"trace[175325614] transaction","detail":"{read_only:false; response_revision:4625; number_of_response:1; }","duration":"131.503615ms","start":"2026-06-08T22:16:05.51003Z","end":"2026-06-08T22:16:05.641534Z","steps":["trace[175325614] 'process raft request' (duration: 130.891181ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:06.525003Z","caller":"traceutil/trace.go:171","msg":"trace[1055944277] transaction","detail":"{read_only:false; response_revision:4640; number_of_response:1; }","duration":"178.421189ms","start":"2026-06-08T22:16:06.346558Z","end":"2026-06-08T22:16:06.52498Z","steps":["trace[1055944277] 'process raft request' (duration: 178.280983ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:06.52523Z","caller":"traceutil/trace.go:171","msg":"trace[1866959060] linearizableReadLoop","detail":"{readStateIndex:4814; appliedIndex:4814; }","duration":"157.77932ms","start":"2026-06-08T22:16:06.36744Z","end":"2026-06-08T22:16:06.525219Z","steps":["trace[1866959060] 'read index received' (duration: 157.771729ms)","trace[1866959060] 'applied index is now lower than readState.Index' (duration: 6.601µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:06.525499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.479277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"warn","ts":"2026-06-08T22:16:06.5255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.035109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-08T22:16:06.525566Z","caller":"traceutil/trace.go:171","msg":"trace[1580751236] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4640; }","duration":"119.557881ms","start":"2026-06-08T22:16:06.405994Z","end":"2026-06-08T22:16:06.525552Z","steps":["trace[1580751236] 'agreement among raft nodes before linearized reading' (duration: 119.361653ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:06.525584Z","caller":"traceutil/trace.go:171","msg":"trace[1836287214] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:4640; }","duration":"158.151163ms","start":"2026-06-08T22:16:06.367415Z","end":"2026-06-08T22:16:06.525566Z","steps":["trace[1836287214] 'agreement among raft nodes before linearized reading' (duration: 157.906034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:08.493514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.91029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-08T22:16:08.49361Z","caller":"traceutil/trace.go:171","msg":"trace[1348017671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4656; }","duration":"124.077546ms","start":"2026-06-08T22:16:08.369521Z","end":"2026-06-08T22:16:08.493599Z","steps":["trace[1348017671] 'range keys from in-memory index tree' (duration: 123.768164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:12.962156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.212492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-08T22:16:12.962277Z","caller":"traceutil/trace.go:171","msg":"trace[1634864134] transaction","detail":"{read_only:false; response_revision:4754; number_of_response:1; }","duration":"604.102349ms","start":"2026-06-08T22:16:12.358155Z","end":"2026-06-08T22:16:12.962258Z","steps":["trace[1634864134] 'process raft request' (duration: 249.702788ms)","trace[1634864134] 'compare' (duration: 354.083447ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:12.962611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:12.358138Z","time spent":"604.173371ms","remote":"127.0.0.1:60848","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3751,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:16:13.24494Z","caller":"traceutil/trace.go:171","msg":"trace[1326851945] transaction","detail":"{read_only:false; response_revision:4755; number_of_response:1; }","duration":"870.624391ms","start":"2026-06-08T22:16:12.374292Z","end":"2026-06-08T22:16:13.244916Z","steps":["trace[1326851945] 'process raft request' (duration: 825.249597ms)","trace[1326851945] 'compare' (duration: 45.074252ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:13.245189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:12.374273Z","time spent":"870.836609ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-08T22:16:13.245178Z","caller":"traceutil/trace.go:171","msg":"trace[2128305681] linearizableReadLoop","detail":"{readStateIndex:4931; appliedIndex:4929; }","duration":"699.374986ms","start":"2026-06-08T22:16:12.545784Z","end":"2026-06-08T22:16:13.245159Z","steps":["trace[2128305681] 'read index received' (duration: 62.084781ms)","trace[2128305681] 'applied index is now lower than readState.Index' (duration: 637.288785ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:13.245333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.531792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8ea31a4-93b0-4f1d-ad16-36a3f708a3dd\" ","response":"range_response_count:1 size:3766"} {"level":"info","ts":"2026-06-08T22:16:13.245601Z","caller":"traceutil/trace.go:171","msg":"trace[1441109545] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e8ea31a4-93b0-4f1d-ad16-36a3f708a3dd; range_end:; response_count:1; response_revision:4757; }","duration":"699.843725ms","start":"2026-06-08T22:16:12.545743Z","end":"2026-06-08T22:16:13.245586Z","steps":["trace[1441109545] 'agreement among raft nodes before linearized reading' (duration: 699.47918ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:13.245643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.303221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-08T22:16:13.24565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:12.545723Z","time spent":"699.914948ms","remote":"127.0.0.1:60848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3788,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e8ea31a4-93b0-4f1d-ad16-36a3f708a3dd\" "} {"level":"info","ts":"2026-06-08T22:16:13.245678Z","caller":"traceutil/trace.go:171","msg":"trace[1991849240] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4757; }","duration":"688.343343ms","start":"2026-06-08T22:16:12.557321Z","end":"2026-06-08T22:16:13.245664Z","steps":["trace[1991849240] 'agreement among raft nodes before linearized reading' (duration: 688.25955ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:13.245717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:12.557316Z","time spent":"688.393655ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-08T22:16:13.245065Z","caller":"traceutil/trace.go:171","msg":"trace[151111762] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"692.352397ms","start":"2026-06-08T22:16:12.552686Z","end":"2026-06-08T22:16:13.245038Z","steps":["trace[151111762] 'process raft request' (duration: 692.041064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:13.245791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:12.552668Z","time spent":"693.098529ms","remote":"127.0.0.1:60750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2581,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-08T22:16:13.245898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.38604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-06-08T22:16:13.245934Z","caller":"traceutil/trace.go:171","msg":"trace[1738260982] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4757; }","duration":"278.465694ms","start":"2026-06-08T22:16:12.967457Z","end":"2026-06-08T22:16:13.245923Z","steps":["trace[1738260982] 'agreement among raft nodes before linearized reading' (duration: 278.359739ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:13.246096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.903729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:16:13.246131Z","caller":"traceutil/trace.go:171","msg":"trace[177011058] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4757; }","duration":"405.968132ms","start":"2026-06-08T22:16:12.840154Z","end":"2026-06-08T22:16:13.246122Z","steps":["trace[177011058] 'agreement among raft nodes before linearized reading' (duration: 405.92056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:13.246159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:12.840135Z","time spent":"406.017604ms","remote":"127.0.0.1:60632","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-08T22:16:13.246253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"643.023212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-06-08T22:16:13.246316Z","caller":"traceutil/trace.go:171","msg":"trace[1721315719] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4757; }","duration":"643.096144ms","start":"2026-06-08T22:16:12.603196Z","end":"2026-06-08T22:16:13.246292Z","steps":["trace[1721315719] 'agreement among raft nodes before linearized reading' (duration: 642.904006ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:13.246355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-08T22:16:12.603187Z","time spent":"643.160237ms","remote":"127.0.0.1:60848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12234,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-08T22:16:23.622607Z","caller":"traceutil/trace.go:171","msg":"trace[1695853256] linearizableReadLoop","detail":"{readStateIndex:5070; appliedIndex:5069; }","duration":"118.68259ms","start":"2026-06-08T22:16:23.503908Z","end":"2026-06-08T22:16:23.622591Z","steps":["trace[1695853256] 'read index received' (duration: 118.535684ms)","trace[1695853256] 'applied index is now lower than readState.Index' (duration: 145.966µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:16:23.622689Z","caller":"traceutil/trace.go:171","msg":"trace[134785069] transaction","detail":"{read_only:false; response_revision:4889; number_of_response:1; }","duration":"152.880815ms","start":"2026-06-08T22:16:23.4698Z","end":"2026-06-08T22:16:23.622681Z","steps":["trace[134785069] 'process raft request' (duration: 152.648605ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:23.62298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.495719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-06-08T22:16:23.623077Z","caller":"traceutil/trace.go:171","msg":"trace[896319897] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4889; }","duration":"117.617215ms","start":"2026-06-08T22:16:23.505439Z","end":"2026-06-08T22:16:23.623056Z","steps":["trace[896319897] 'agreement among raft nodes before linearized reading' (duration: 117.397385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:23.623237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.271986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-06-08T22:16:23.623274Z","caller":"traceutil/trace.go:171","msg":"trace[198779250] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4889; }","duration":"119.39493ms","start":"2026-06-08T22:16:23.503868Z","end":"2026-06-08T22:16:23.623263Z","steps":["trace[198779250] 'agreement among raft nodes before linearized reading' (duration: 119.204893ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:23.822649Z","caller":"traceutil/trace.go:171","msg":"trace[1323618413] transaction","detail":"{read_only:false; response_revision:4891; number_of_response:1; }","duration":"192.466283ms","start":"2026-06-08T22:16:23.63016Z","end":"2026-06-08T22:16:23.822626Z","steps":["trace[1323618413] 'process raft request' (duration: 192.283314ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:23.822984Z","caller":"traceutil/trace.go:171","msg":"trace[1803551136] transaction","detail":"{read_only:false; response_revision:4892; number_of_response:1; }","duration":"192.747815ms","start":"2026-06-08T22:16:23.630212Z","end":"2026-06-08T22:16:23.82296Z","steps":["trace[1803551136] 'process raft request' (duration: 192.323727ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:23.823034Z","caller":"traceutil/trace.go:171","msg":"trace[455239177] transaction","detail":"{read_only:false; response_revision:4893; number_of_response:1; }","duration":"191.98523ms","start":"2026-06-08T22:16:23.63104Z","end":"2026-06-08T22:16:23.823026Z","steps":["trace[455239177] 'process raft request' (duration: 191.531061ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:23.822781Z","caller":"traceutil/trace.go:171","msg":"trace[2059694236] transaction","detail":"{read_only:false; response_revision:4890; number_of_response:1; }","duration":"193.868853ms","start":"2026-06-08T22:16:23.628877Z","end":"2026-06-08T22:16:23.822746Z","steps":["trace[2059694236] 'process raft request' (duration: 94.515161ms)","trace[2059694236] 'compare' (duration: 98.829219ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:16:23.822866Z","caller":"traceutil/trace.go:171","msg":"trace[1056496972] linearizableReadLoop","detail":"{readStateIndex:5074; appliedIndex:5070; }","duration":"179.404745ms","start":"2026-06-08T22:16:23.643452Z","end":"2026-06-08T22:16:23.822856Z","steps":["trace[1056496972] 'read index received' (duration: 79.937028ms)","trace[1056496972] 'applied index is now lower than readState.Index' (duration: 99.466987ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:23.822977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.510721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-08T22:16:23.823341Z","caller":"traceutil/trace.go:171","msg":"trace[84087358] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:4893; }","duration":"179.907407ms","start":"2026-06-08T22:16:23.64342Z","end":"2026-06-08T22:16:23.823327Z","steps":["trace[84087358] 'agreement among raft nodes before linearized reading' (duration: 179.465487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:23.846173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.035809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:16:23.846309Z","caller":"traceutil/trace.go:171","msg":"trace[1201826970] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4894; }","duration":"155.187265ms","start":"2026-06-08T22:16:23.691105Z","end":"2026-06-08T22:16:23.846292Z","steps":["trace[1201826970] 'agreement among raft nodes before linearized reading' (duration: 154.939234ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:23.846211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.0686ms","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-06-08T22:16:23.846438Z","caller":"traceutil/trace.go:171","msg":"trace[392465126] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4894; }","duration":"123.324662ms","start":"2026-06-08T22:16:23.723078Z","end":"2026-06-08T22:16:23.846403Z","steps":["trace[392465126] 'agreement among raft nodes before linearized reading' (duration: 122.940466ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:29.987181Z","caller":"traceutil/trace.go:171","msg":"trace[717429968] linearizableReadLoop","detail":"{readStateIndex:5126; appliedIndex:5125; }","duration":"104.687556ms","start":"2026-06-08T22:16:29.882461Z","end":"2026-06-08T22:16:29.987148Z","steps":["trace[717429968] 'read index received' (duration: 58.300049ms)","trace[717429968] 'applied index is now lower than readState.Index' (duration: 46.386137ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:16:29.987399Z","caller":"traceutil/trace.go:171","msg":"trace[190417231] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"111.399535ms","start":"2026-06-08T22:16:29.875982Z","end":"2026-06-08T22:16:29.987381Z","steps":["trace[190417231] 'process raft request' (duration: 64.793489ms)","trace[190417231] 'compare' (duration: 46.21919ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:29.987552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.070023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-08T22:16:29.987632Z","caller":"traceutil/trace.go:171","msg":"trace[893467039] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4944; }","duration":"105.175069ms","start":"2026-06-08T22:16:29.882444Z","end":"2026-06-08T22:16:29.987619Z","steps":["trace[893467039] 'agreement among raft nodes before linearized reading' (duration: 104.969929ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:29.987675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.827248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-08T22:16:29.987808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.464251ms","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-06-08T22:16:29.987844Z","caller":"traceutil/trace.go:171","msg":"trace[747690419] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4944; }","duration":"103.498473ms","start":"2026-06-08T22:16:29.884337Z","end":"2026-06-08T22:16:29.987835Z","steps":["trace[747690419] 'agreement among raft nodes before linearized reading' (duration: 103.422349ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:29.987782Z","caller":"traceutil/trace.go:171","msg":"trace[1410254189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4944; }","duration":"103.961664ms","start":"2026-06-08T22:16:29.8838Z","end":"2026-06-08T22:16:29.987762Z","steps":["trace[1410254189] 'agreement among raft nodes before linearized reading' (duration: 103.67579ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:29.987722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.024143ms","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-06-08T22:16:29.988307Z","caller":"traceutil/trace.go:171","msg":"trace[1411809895] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4944; }","duration":"103.620278ms","start":"2026-06-08T22:16:29.884672Z","end":"2026-06-08T22:16:29.988293Z","steps":["trace[1411809895] 'agreement among raft nodes before linearized reading' (duration: 102.98229ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.1907Z","caller":"traceutil/trace.go:171","msg":"trace[662449644] transaction","detail":"{read_only:false; response_revision:5032; number_of_response:1; }","duration":"112.431205ms","start":"2026-06-08T22:16:46.078244Z","end":"2026-06-08T22:16:46.190676Z","steps":["trace[662449644] 'process raft request' (duration: 112.285559ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.258096Z","caller":"traceutil/trace.go:171","msg":"trace[291302613] transaction","detail":"{read_only:false; response_revision:5033; number_of_response:1; }","duration":"145.915491ms","start":"2026-06-08T22:16:46.112164Z","end":"2026-06-08T22:16:46.258079Z","steps":["trace[291302613] 'process raft request' (duration: 145.484601ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.366728Z","caller":"traceutil/trace.go:171","msg":"trace[787075581] transaction","detail":"{read_only:false; response_revision:5034; number_of_response:1; }","duration":"104.330099ms","start":"2026-06-08T22:16:46.262364Z","end":"2026-06-08T22:16:46.366694Z","steps":["trace[787075581] 'process raft request' (duration: 104.185552ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.366857Z","caller":"traceutil/trace.go:171","msg":"trace[2081378769] transaction","detail":"{read_only:false; response_revision:5035; number_of_response:1; }","duration":"104.366421ms","start":"2026-06-08T22:16:46.262476Z","end":"2026-06-08T22:16:46.366843Z","steps":["trace[2081378769] 'process raft request' (duration: 104.148841ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.3669Z","caller":"traceutil/trace.go:171","msg":"trace[1882395267] transaction","detail":"{read_only:false; response_revision:5037; number_of_response:1; }","duration":"104.057147ms","start":"2026-06-08T22:16:46.262829Z","end":"2026-06-08T22:16:46.366887Z","steps":["trace[1882395267] 'process raft request' (duration: 103.829126ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.366952Z","caller":"traceutil/trace.go:171","msg":"trace[783685991] transaction","detail":"{read_only:false; response_revision:5038; number_of_response:1; }","duration":"102.432199ms","start":"2026-06-08T22:16:46.264516Z","end":"2026-06-08T22:16:46.366948Z","steps":["trace[783685991] 'process raft request' (duration: 102.158136ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.366977Z","caller":"traceutil/trace.go:171","msg":"trace[1462649559] transaction","detail":"{read_only:false; response_revision:5036; number_of_response:1; }","duration":"104.231535ms","start":"2026-06-08T22:16:46.262739Z","end":"2026-06-08T22:16:46.366971Z","steps":["trace[1462649559] 'process raft request' (duration: 103.902899ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.567157Z","caller":"traceutil/trace.go:171","msg":"trace[482128249] linearizableReadLoop","detail":"{readStateIndex:5226; appliedIndex:5225; }","duration":"134.239324ms","start":"2026-06-08T22:16:46.432892Z","end":"2026-06-08T22:16:46.567131Z","steps":["trace[482128249] 'read index received' (duration: 41.742718ms)","trace[482128249] 'applied index is now lower than readState.Index' (duration: 92.493846ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:16:46.567414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.499876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-08T22:16:46.567456Z","caller":"traceutil/trace.go:171","msg":"trace[510149287] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:5040; }","duration":"134.58439ms","start":"2026-06-08T22:16:46.432862Z","end":"2026-06-08T22:16:46.567446Z","steps":["trace[510149287] 'agreement among raft nodes before linearized reading' (duration: 134.426782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:46.567606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.855484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:16:46.567673Z","caller":"traceutil/trace.go:171","msg":"trace[1941378795] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:5040; }","duration":"100.97381ms","start":"2026-06-08T22:16:46.466685Z","end":"2026-06-08T22:16:46.567659Z","steps":["trace[1941378795] 'agreement among raft nodes before linearized reading' (duration: 100.829972ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:46.567735Z","caller":"traceutil/trace.go:171","msg":"trace[381268763] transaction","detail":"{read_only:false; response_revision:5040; number_of_response:1; }","duration":"151.15075ms","start":"2026-06-08T22:16:46.416119Z","end":"2026-06-08T22:16:46.567269Z","steps":["trace[381268763] 'process raft request' (duration: 58.517047ms)","trace[381268763] 'compare' (duration: 92.381641ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:16:52.052773Z","caller":"traceutil/trace.go:171","msg":"trace[1409440257] transaction","detail":"{read_only:false; response_revision:5143; number_of_response:1; }","duration":"130.104482ms","start":"2026-06-08T22:16:51.922635Z","end":"2026-06-08T22:16:52.052739Z","steps":["trace[1409440257] 'process raft request' (duration: 129.977586ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:52.145232Z","caller":"traceutil/trace.go:171","msg":"trace[466905454] transaction","detail":"{read_only:false; response_revision:5145; number_of_response:1; }","duration":"165.279602ms","start":"2026-06-08T22:16:51.979927Z","end":"2026-06-08T22:16:52.145207Z","steps":["trace[466905454] 'process raft request' (duration: 165.046471ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:16:52.145311Z","caller":"traceutil/trace.go:171","msg":"trace[655918872] linearizableReadLoop","detail":"{readStateIndex:5332; appliedIndex:5330; }","duration":"168.370152ms","start":"2026-06-08T22:16:51.976918Z","end":"2026-06-08T22:16:52.145289Z","steps":["trace[655918872] 'read index received' (duration: 75.709907ms)","trace[655918872] 'applied index is now lower than readState.Index' (duration: 92.659025ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:16:52.145388Z","caller":"traceutil/trace.go:171","msg":"trace[139575455] transaction","detail":"{read_only:false; response_revision:5144; number_of_response:1; }","duration":"204.622508ms","start":"2026-06-08T22:16:51.940737Z","end":"2026-06-08T22:16:52.145359Z","steps":["trace[139575455] 'process raft request' (duration: 197.133764ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:16:52.146296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.35898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206973"} {"level":"info","ts":"2026-06-08T22:16:52.146359Z","caller":"traceutil/trace.go:171","msg":"trace[1931954398] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:5146; }","duration":"169.440843ms","start":"2026-06-08T22:16:51.976888Z","end":"2026-06-08T22:16:52.146329Z","steps":["trace[1931954398] 'agreement among raft nodes before linearized reading' (duration: 168.481766ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:17:03.228521Z","caller":"traceutil/trace.go:171","msg":"trace[2011994281] transaction","detail":"{read_only:false; response_revision:5225; number_of_response:1; }","duration":"151.943844ms","start":"2026-06-08T22:17:03.076553Z","end":"2026-06-08T22:17:03.228497Z","steps":["trace[2011994281] 'process raft request' (duration: 151.785316ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:17:07.960304Z","caller":"traceutil/trace.go:171","msg":"trace[359168539] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"126.500967ms","start":"2026-06-08T22:17:07.833768Z","end":"2026-06-08T22:17:07.960269Z","steps":["trace[359168539] 'process raft request' (duration: 80.115067ms)","trace[359168539] 'compare' (duration: 46.119737ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:17:12.691144Z","caller":"traceutil/trace.go:171","msg":"trace[837952224] linearizableReadLoop","detail":"{readStateIndex:5490; appliedIndex:5488; }","duration":"130.155834ms","start":"2026-06-08T22:17:12.560959Z","end":"2026-06-08T22:17:12.691115Z","steps":["trace[837952224] 'read index received' (duration: 72.960443ms)","trace[837952224] 'applied index is now lower than readState.Index' (duration: 57.193961ms)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:17:12.691357Z","caller":"traceutil/trace.go:171","msg":"trace[2112023125] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"130.257729ms","start":"2026-06-08T22:17:12.56104Z","end":"2026-06-08T22:17:12.691297Z","steps":["trace[2112023125] 'process raft request' (duration: 130.018997ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:17:12.691611Z","caller":"traceutil/trace.go:171","msg":"trace[1284497765] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"131.886014ms","start":"2026-06-08T22:17:12.559697Z","end":"2026-06-08T22:17:12.691583Z","steps":["trace[1284497765] 'process raft request' (duration: 74.221459ms)","trace[1284497765] 'compare' (duration: 56.899735ms)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:17:12.691665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.669971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-08T22:17:12.691812Z","caller":"traceutil/trace.go:171","msg":"trace[1045016910] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5298; }","duration":"130.875391ms","start":"2026-06-08T22:17:12.560916Z","end":"2026-06-08T22:17:12.691792Z","steps":["trace[1045016910] 'agreement among raft nodes before linearized reading' (duration: 130.361664ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:17:12.692098Z","caller":"traceutil/trace.go:171","msg":"trace[1303533331] transaction","detail":"{read_only:false; response_revision:5297; number_of_response:1; }","duration":"132.286404ms","start":"2026-06-08T22:17:12.559789Z","end":"2026-06-08T22:17:12.692076Z","steps":["trace[1303533331] 'process raft request' (duration: 131.203308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:17:17.969804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.832743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-08T22:17:17.96989Z","caller":"traceutil/trace.go:171","msg":"trace[32858892] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5326; }","duration":"248.96913ms","start":"2026-06-08T22:17:17.720902Z","end":"2026-06-08T22:17:17.969872Z","steps":["trace[32858892] 'range keys from in-memory index tree' (duration: 248.656644ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:17:17.98253Z","caller":"traceutil/trace.go:171","msg":"trace[1007958965] linearizableReadLoop","detail":"{readStateIndex:5521; appliedIndex:5520; }","duration":"142.781832ms","start":"2026-06-08T22:17:17.839733Z","end":"2026-06-08T22:17:17.982515Z","steps":["trace[1007958965] 'read index received' (duration: 142.674596ms)","trace[1007958965] 'applied index is now lower than readState.Index' (duration: 106.526µs)"],"step_count":2} {"level":"warn","ts":"2026-06-08T22:17:17.982617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.877046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-08T22:17:17.982641Z","caller":"traceutil/trace.go:171","msg":"trace[884607129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5327; }","duration":"142.946831ms","start":"2026-06-08T22:17:17.839685Z","end":"2026-06-08T22:17:17.982632Z","steps":["trace[884607129] 'agreement among raft nodes before linearized reading' (duration: 142.894307ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:17:17.98274Z","caller":"traceutil/trace.go:171","msg":"trace[523346467] transaction","detail":"{read_only:false; response_revision:5327; number_of_response:1; }","duration":"173.651094ms","start":"2026-06-08T22:17:17.80892Z","end":"2026-06-08T22:17:17.982572Z","steps":["trace[523346467] 'process raft request' (duration: 173.487816ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:17:43.281493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2836} {"level":"info","ts":"2026-06-08T22:17:43.380895Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2836,"took":"98.068279ms","hash":2862265773,"current-db-size-bytes":53260288,"current-db-size":"53 MB","current-db-size-in-use-bytes":29356032,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-08T22:17:43.38096Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2862265773,"revision":2836,"compact-revision":-1} {"level":"info","ts":"2026-06-08T22:19:45.682289Z","caller":"traceutil/trace.go:171","msg":"trace[1476309475] linearizableReadLoop","detail":"{readStateIndex:6581; appliedIndex:6580; }","duration":"123.796568ms","start":"2026-06-08T22:19:45.558466Z","end":"2026-06-08T22:19:45.682263Z","steps":["trace[1476309475] 'read index received' (duration: 123.576634ms)","trace[1476309475] 'applied index is now lower than readState.Index' (duration: 219.044µs)"],"step_count":2} {"level":"info","ts":"2026-06-08T22:19:45.682398Z","caller":"traceutil/trace.go:171","msg":"trace[202380767] transaction","detail":"{read_only:false; response_revision:6352; number_of_response:1; }","duration":"287.956411ms","start":"2026-06-08T22:19:45.394403Z","end":"2026-06-08T22:19:45.682359Z","steps":["trace[202380767] 'process raft request' (duration: 287.709175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-08T22:19:45.68254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.054594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-08T22:19:45.68266Z","caller":"traceutil/trace.go:171","msg":"trace[349174277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6352; }","duration":"124.223735ms","start":"2026-06-08T22:19:45.558415Z","end":"2026-06-08T22:19:45.682639Z","steps":["trace[349174277] 'agreement among raft nodes before linearized reading' (duration: 123.961238ms)"],"step_count":1} {"level":"info","ts":"2026-06-08T22:22:43.289486Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5515} {"level":"info","ts":"2026-06-08T22:22:43.384844Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5515,"took":"93.945542ms","hash":3523987471,"current-db-size-bytes":53260288,"current-db-size":"53 MB","current-db-size-in-use-bytes":18460672,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-06-08T22:22:43.384891Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3523987471,"revision":5515,"compact-revision":2836}