{"level":"warn","ts":"2026-04-16T00:47:49.043915Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T00:47:49.044045Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.238: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.238:2380","--initial-cluster=instance=https://199.204.45.238:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.238:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.238:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-16T00:47:49.044176Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-16T00:47:49.04421Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-04-16T00:47:49.044236Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T00:47:49.044771Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"]} {"level":"info","ts":"2026-04-16T00:47:49.044878Z","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.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.238:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-16T00:47:49.048704Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.604339ms"} {"level":"info","ts":"2026-04-16T00:47:49.053835Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d7dbc9f5893cc1f6","cluster-id":"823d1d08ab21430c"} {"level":"info","ts":"2026-04-16T00:47:49.053909Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T00:47:49.053939Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 0"} {"level":"info","ts":"2026-04-16T00:47:49.053961Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d7dbc9f5893cc1f6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T00:47:49.053988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became follower at term 1"} {"level":"info","ts":"2026-04-16T00:47:49.054031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"warn","ts":"2026-04-16T00:47:49.061469Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T00:47:49.062878Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T00:47:49.064048Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-16T00:47:49.0667Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d7dbc9f5893cc1f6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T00:47:49.066969Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d7dbc9f5893cc1f6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T00:47:49.067135Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T00:47:49.06726Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T00:47:49.067277Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-16T00:47:49.067696Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 switched to configuration voters=(15554247794460770806)"} {"level":"info","ts":"2026-04-16T00:47:49.067827Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","added-peer-id":"d7dbc9f5893cc1f6","added-peer-peer-urls":["https://199.204.45.238:2380"]} {"level":"info","ts":"2026-04-16T00:47:49.071823Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-16T00:47:49.071898Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-04-16T00:47:49.072012Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.238:2380"} {"level":"info","ts":"2026-04-16T00:47:49.072831Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d7dbc9f5893cc1f6","initial-advertise-peer-urls":["https://199.204.45.238:2380"],"listen-peer-urls":["https://199.204.45.238:2380"],"advertise-client-urls":["https://199.204.45.238:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.238:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T00:47:49.07287Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T00:47:49.554512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T00:47:49.554585Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T00:47:49.55461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgPreVoteResp from d7dbc9f5893cc1f6 at term 1"} {"level":"info","ts":"2026-04-16T00:47:49.554622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became candidate at term 2"} {"level":"info","ts":"2026-04-16T00:47:49.554658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 received MsgVoteResp from d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-04-16T00:47:49.554669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d7dbc9f5893cc1f6 became leader at term 2"} {"level":"info","ts":"2026-04-16T00:47:49.554676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d7dbc9f5893cc1f6 elected leader d7dbc9f5893cc1f6 at term 2"} {"level":"info","ts":"2026-04-16T00:47:49.555435Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T00:47:49.556366Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d7dbc9f5893cc1f6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.238:2379]}","request-path":"/0/members/d7dbc9f5893cc1f6/attributes","cluster-id":"823d1d08ab21430c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T00:47:49.556444Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T00:47:49.556711Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"823d1d08ab21430c","local-member-id":"d7dbc9f5893cc1f6","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T00:47:49.556905Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T00:47:49.556989Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T00:47:49.557025Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T00:47:49.55726Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T00:47:49.557312Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T00:47:49.559984Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T00:47:49.560299Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.238:2379"} {"level":"warn","ts":"2026-04-16T00:47:51.121494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.453973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-16T00:47:51.121866Z","caller":"traceutil/trace.go:171","msg":"trace[25338327] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"192.233446ms","start":"2026-04-16T00:47:50.929596Z","end":"2026-04-16T00:47:51.12183Z","steps":["trace[25338327] 'process raft request' (duration: 192.060502ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:51.121969Z","caller":"traceutil/trace.go:171","msg":"trace[1787499568] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"164.256916ms","start":"2026-04-16T00:47:50.957697Z","end":"2026-04-16T00:47:51.121954Z","steps":["trace[1787499568] 'process raft request' (duration: 164.065871ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:51.12207Z","caller":"traceutil/trace.go:171","msg":"trace[1765750104] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"155.659719ms","start":"2026-04-16T00:47:50.966386Z","end":"2026-04-16T00:47:51.122046Z","steps":["trace[1765750104] 'process raft request' (duration: 155.608318ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:51.122172Z","caller":"traceutil/trace.go:171","msg":"trace[951471329] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"164.245636ms","start":"2026-04-16T00:47:50.957869Z","end":"2026-04-16T00:47:51.122114Z","steps":["trace[951471329] 'process raft request' (duration: 163.944428ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:51.122189Z","caller":"traceutil/trace.go:171","msg":"trace[110554055] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"164.200845ms","start":"2026-04-16T00:47:50.957888Z","end":"2026-04-16T00:47:51.122089Z","steps":["trace[110554055] 'process raft request' (duration: 163.949578ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:51.122408Z","caller":"traceutil/trace.go:171","msg":"trace[940446567] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"164.450151ms","start":"2026-04-16T00:47:50.957946Z","end":"2026-04-16T00:47:51.122396Z","steps":["trace[940446567] 'process raft request' (duration: 163.924806ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:51.121811Z","caller":"traceutil/trace.go:171","msg":"trace[399119411] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"194.722965ms","start":"2026-04-16T00:47:50.927051Z","end":"2026-04-16T00:47:51.121774Z","steps":["trace[399119411] 'process raft request' (duration: 83.373567ms)","trace[399119411] 'compare' (duration: 110.139474ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:47:51.122496Z","caller":"traceutil/trace.go:171","msg":"trace[1089321677] linearizableReadLoop","detail":"{readStateIndex:18; appliedIndex:15; }","duration":"167.028982ms","start":"2026-04-16T00:47:50.955444Z","end":"2026-04-16T00:47:51.122473Z","steps":["trace[1089321677] 'read index received' (duration: 55.006705ms)","trace[1089321677] 'applied index is now lower than readState.Index' (duration: 112.020567ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:47:51.122582Z","caller":"traceutil/trace.go:171","msg":"trace[1420522827] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"164.517874ms","start":"2026-04-16T00:47:50.958051Z","end":"2026-04-16T00:47:51.122569Z","steps":["trace[1420522827] 'process raft request' (duration: 163.911517ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:51.122564Z","caller":"traceutil/trace.go:171","msg":"trace[1660562141] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"184.00427ms","start":"2026-04-16T00:47:50.938449Z","end":"2026-04-16T00:47:51.122453Z","steps":["trace[1660562141] 'process raft request' (duration: 183.261289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:51.122712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.244519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-16T00:47:51.122754Z","caller":"traceutil/trace.go:171","msg":"trace[178604566] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"167.326131ms","start":"2026-04-16T00:47:50.955416Z","end":"2026-04-16T00:47:51.122742Z","steps":["trace[178604566] 'agreement among raft nodes before linearized reading' (duration: 167.142556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:51.122758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.4187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-16T00:47:51.122885Z","caller":"traceutil/trace.go:171","msg":"trace[1883115036] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:20; }","duration":"164.602086ms","start":"2026-04-16T00:47:50.958263Z","end":"2026-04-16T00:47:51.122865Z","steps":["trace[1883115036] 'agreement among raft nodes before linearized reading' (duration: 164.312848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:55.32574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.408287ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T00:47:55.325823Z","caller":"traceutil/trace.go:171","msg":"trace[709168628] linearizableReadLoop","detail":"{readStateIndex:271; appliedIndex:270; }","duration":"422.835915ms","start":"2026-04-16T00:47:54.902973Z","end":"2026-04-16T00:47:55.325809Z","steps":["trace[709168628] 'read index received' (duration: 2.251643ms)","trace[709168628] 'applied index is now lower than readState.Index' (duration: 420.583022ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:47:55.326012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.031032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-04-16T00:47:55.326001Z","caller":"traceutil/trace.go:171","msg":"trace[367163646] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"566.180533ms","start":"2026-04-16T00:47:54.759714Z","end":"2026-04-16T00:47:55.325894Z","steps":["trace[367163646] 'process raft request' (duration: 145.505738ms)","trace[367163646] 'compare' (duration: 420.129809ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:47:55.326041Z","caller":"traceutil/trace.go:171","msg":"trace[635262466] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:264; }","duration":"423.081362ms","start":"2026-04-16T00:47:54.902951Z","end":"2026-04-16T00:47:55.326033Z","steps":["trace[635262466] 'agreement among raft nodes before linearized reading' (duration: 422.973659ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:55.326073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:54.902938Z","time spent":"423.129893ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4004,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-04-16T00:47:55.326249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:54.759696Z","time spent":"566.375489ms","remote":"127.0.0.1:36552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":186,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T00:47:56.102713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.106296ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:5"} {"level":"info","ts":"2026-04-16T00:47:56.102933Z","caller":"traceutil/trace.go:171","msg":"trace[1809381835] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:271; }","duration":"777.07286ms","start":"2026-04-16T00:47:55.325842Z","end":"2026-04-16T00:47:56.102915Z","steps":["trace[1809381835] 'read index received' (duration: 490.703957ms)","trace[1809381835] 'applied index is now lower than readState.Index' (duration: 286.368133ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:47:56.103014Z","caller":"traceutil/trace.go:171","msg":"trace[888899212] transaction","detail":"{read_only:false; number_of_response:0; response_revision:264; }","duration":"1.199232757s","start":"2026-04-16T00:47:54.903775Z","end":"2026-04-16T00:47:56.103008Z","steps":["trace[888899212] 'process raft request' (duration: 1.199111544s)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:56.103024Z","caller":"traceutil/trace.go:171","msg":"trace[1871383639] transaction","detail":"{read_only:false; number_of_response:0; response_revision:264; }","duration":"1.199247598s","start":"2026-04-16T00:47:54.903743Z","end":"2026-04-16T00:47:56.102991Z","steps":["trace[1871383639] 'process raft request' (duration: 1.199121844s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:56.103122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033455333s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:47:56.103151Z","caller":"traceutil/trace.go:171","msg":"trace[184958490] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:264; }","duration":"1.033528696s","start":"2026-04-16T00:47:55.069614Z","end":"2026-04-16T00:47:56.103143Z","steps":["trace[184958490] 'agreement among raft nodes before linearized reading' (duration: 1.033471624s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:56.103174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:55.069569Z","time spent":"1.033599568s","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T00:47:56.103128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.270532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:47:56.103213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:54.903737Z","time spent":"1.199379461s","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T00:47:56.103234Z","caller":"traceutil/trace.go:171","msg":"trace[204369125] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:264; }","duration":"965.411675ms","start":"2026-04-16T00:47:55.137802Z","end":"2026-04-16T00:47:56.103213Z","steps":["trace[204369125] 'agreement among raft nodes before linearized reading' (duration: 965.24186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:56.103062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:54.903772Z","time spent":"1.199269118s","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T00:47:56.10347Z","caller":"traceutil/trace.go:171","msg":"trace[1271706068] transaction","detail":"{read_only:false; number_of_response:0; response_revision:264; }","duration":"1.199815074s","start":"2026-04-16T00:47:54.903641Z","end":"2026-04-16T00:47:56.103456Z","steps":["trace[1271706068] 'process raft request' (duration: 1.199193866s)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:56.103431Z","caller":"traceutil/trace.go:171","msg":"trace[98261375] transaction","detail":"{read_only:false; number_of_response:0; response_revision:264; }","duration":"1.200346769s","start":"2026-04-16T00:47:54.903075Z","end":"2026-04-16T00:47:56.103422Z","steps":["trace[98261375] 'process raft request' (duration: 913.45141ms)","trace[98261375] 'compare' (duration: 286.012804ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:47:56.103536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:54.903067Z","time spent":"1.200452342s","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T00:47:56.103552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:54.903618Z","time spent":"1.199887975s","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":29,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T00:47:56.103609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.156036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T00:47:56.103706Z","caller":"traceutil/trace.go:171","msg":"trace[977965642] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:264; }","duration":"788.29184ms","start":"2026-04-16T00:47:55.315384Z","end":"2026-04-16T00:47:56.103675Z","steps":["trace[977965642] 'agreement among raft nodes before linearized reading' (duration: 788.081854ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:56.103756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:55.315361Z","time spent":"788.386283ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T00:47:56.10435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:55.13779Z","time spent":"966.539488ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T00:47:56.194167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"864.517857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:47:56.194196Z","caller":"traceutil/trace.go:171","msg":"trace[1199696814] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"849.54405ms","start":"2026-04-16T00:47:55.344622Z","end":"2026-04-16T00:47:56.194166Z","steps":["trace[1199696814] 'process raft request' (duration: 849.228991ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:47:56.194235Z","caller":"traceutil/trace.go:171","msg":"trace[2135187049] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:0; response_revision:265; }","duration":"864.639401ms","start":"2026-04-16T00:47:55.32958Z","end":"2026-04-16T00:47:56.194219Z","steps":["trace[2135187049] 'agreement among raft nodes before linearized reading' (duration: 864.538688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:56.194294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:55.32956Z","time spent":"864.726493ms","remote":"127.0.0.1:36552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" "} {"level":"warn","ts":"2026-04-16T00:47:56.19422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"583.230485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T00:47:56.194365Z","caller":"traceutil/trace.go:171","msg":"trace[400560924] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:265; }","duration":"583.447072ms","start":"2026-04-16T00:47:55.610905Z","end":"2026-04-16T00:47:56.194352Z","steps":["trace[400560924] 'agreement among raft nodes before linearized reading' (duration: 583.194224ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:47:56.194414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:55.610879Z","time spent":"583.528263ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T00:47:56.194568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:47:55.344607Z","time spent":"849.663364ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:48:11.640175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.086799ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12673"} {"level":"info","ts":"2026-04-16T00:48:11.640273Z","caller":"traceutil/trace.go:171","msg":"trace[528801357] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:416; }","duration":"111.236264ms","start":"2026-04-16T00:48:11.529015Z","end":"2026-04-16T00:48:11.640251Z","steps":["trace[528801357] 'range keys from in-memory index tree' (duration: 110.918484ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:48:20.389881Z","caller":"traceutil/trace.go:171","msg":"trace[324223579] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"192.765655ms","start":"2026-04-16T00:48:20.197084Z","end":"2026-04-16T00:48:20.38985Z","steps":["trace[324223579] 'process raft request' (duration: 165.828706ms)","trace[324223579] 'compare' (duration: 26.66696ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:48:21.572632Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976531751534281399,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T00:48:22.030275Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.223518271s","expected-duration":"1s"} {"level":"info","ts":"2026-04-16T00:48:22.031416Z","caller":"traceutil/trace.go:171","msg":"trace[187041716] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.225480694s","start":"2026-04-16T00:48:20.80591Z","end":"2026-04-16T00:48:22.031391Z","steps":["trace[187041716] 'process raft request' (duration: 1.224859554s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:22.03156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:20.805892Z","time spent":"1.225591547s","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:48:22.038265Z","caller":"traceutil/trace.go:171","msg":"trace[1028845274] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"965.698202ms","start":"2026-04-16T00:48:21.072544Z","end":"2026-04-16T00:48:22.038242Z","steps":["trace[1028845274] 'read index received' (duration: 958.04701ms)","trace[1028845274] 'applied index is now lower than readState.Index' (duration: 7.650292ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:48:22.038378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.814007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:48:22.038415Z","caller":"traceutil/trace.go:171","msg":"trace[1811564518] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"965.904169ms","start":"2026-04-16T00:48:21.0725Z","end":"2026-04-16T00:48:22.038404Z","steps":["trace[1811564518] 'agreement among raft nodes before linearized reading' (duration: 965.807556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:22.03845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:21.072479Z","time spent":"965.9637ms","remote":"127.0.0.1:36330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T00:48:22.038743Z","caller":"traceutil/trace.go:171","msg":"trace[1536564998] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"586.076119ms","start":"2026-04-16T00:48:21.452654Z","end":"2026-04-16T00:48:22.038731Z","steps":["trace[1536564998] 'process raft request' (duration: 585.48967ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:22.038833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:21.452628Z","time spent":"586.146411ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:48:23.569665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.714912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:48:23.569747Z","caller":"traceutil/trace.go:171","msg":"trace[1699798582] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"103.804925ms","start":"2026-04-16T00:48:23.465921Z","end":"2026-04-16T00:48:23.569726Z","steps":["trace[1699798582] 'agreement among raft nodes before linearized reading' (duration: 103.67354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:23.569773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.6368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:48:23.56995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.969236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:48:23.56994Z","caller":"traceutil/trace.go:171","msg":"trace[1731770287] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"103.824296ms","start":"2026-04-16T00:48:23.466092Z","end":"2026-04-16T00:48:23.569916Z","steps":["trace[1731770287] 'agreement among raft nodes before linearized reading' (duration: 103.579268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:23.570004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.015482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:48:23.570029Z","caller":"traceutil/trace.go:171","msg":"trace[1541382328] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"102.048619ms","start":"2026-04-16T00:48:23.467953Z","end":"2026-04-16T00:48:23.570001Z","steps":["trace[1541382328] 'agreement among raft nodes before linearized reading' (duration: 101.958947ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:48:23.570054Z","caller":"traceutil/trace.go:171","msg":"trace[229570413] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"104.089134ms","start":"2026-04-16T00:48:23.465953Z","end":"2026-04-16T00:48:23.570042Z","steps":["trace[229570413] 'agreement among raft nodes before linearized reading' (duration: 103.994661ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:48:23.569833Z","caller":"traceutil/trace.go:171","msg":"trace[90943133] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"101.713089ms","start":"2026-04-16T00:48:23.468085Z","end":"2026-04-16T00:48:23.569798Z","steps":["trace[90943133] 'process raft request' (duration: 80.248108ms)","trace[90943133] 'compare' (duration: 21.152211ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:48:23.569959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.706091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:48:23.570081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.96979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:48:23.569834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.679361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:48:23.570227Z","caller":"traceutil/trace.go:171","msg":"trace[16634607] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"104.158386ms","start":"2026-04-16T00:48:23.466053Z","end":"2026-04-16T00:48:23.570212Z","steps":["trace[16634607] 'agreement among raft nodes before linearized reading' (duration: 103.685011ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:48:23.570206Z","caller":"traceutil/trace.go:171","msg":"trace[1104390658] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"104.152866ms","start":"2026-04-16T00:48:23.466031Z","end":"2026-04-16T00:48:23.570184Z","steps":["trace[1104390658] 'agreement among raft nodes before linearized reading' (duration: 103.898048ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:48:23.570245Z","caller":"traceutil/trace.go:171","msg":"trace[1097784997] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:590; }","duration":"104.047043ms","start":"2026-04-16T00:48:23.466121Z","end":"2026-04-16T00:48:23.570168Z","steps":["trace[1097784997] 'agreement among raft nodes before linearized reading' (duration: 103.526256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:40.937747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.651589ms","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-04-16T00:48:40.938162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.621122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sw2lv\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-16T00:48:40.938191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.565142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T00:48:40.938239Z","caller":"traceutil/trace.go:171","msg":"trace[29043748] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sw2lv; range_end:; response_count:1; response_revision:739; }","duration":"865.746696ms","start":"2026-04-16T00:48:40.072476Z","end":"2026-04-16T00:48:40.938222Z","steps":["trace[29043748] 'range keys from in-memory index tree' (duration: 865.459067ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:48:40.938288Z","caller":"traceutil/trace.go:171","msg":"trace[365745143] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:739; }","duration":"417.717827ms","start":"2026-04-16T00:48:40.520554Z","end":"2026-04-16T00:48:40.938272Z","steps":["trace[365745143] 'range keys from in-memory index tree' (duration: 417.400717ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:40.938297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:40.072455Z","time spent":"865.832989ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-sw2lv\" "} {"level":"warn","ts":"2026-04-16T00:48:40.938333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:40.52053Z","time spent":"417.794859ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T00:48:40.938309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.879663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:48:40.938433Z","caller":"traceutil/trace.go:171","msg":"trace[831728564] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:739; }","duration":"867.047839ms","start":"2026-04-16T00:48:40.071367Z","end":"2026-04-16T00:48:40.938415Z","steps":["trace[831728564] 'range keys from in-memory index tree' (duration: 866.77587ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:40.938508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:40.071347Z","time spent":"867.150302ms","remote":"127.0.0.1:36316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T00:48:40.938508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.135603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-16T00:48:40.938509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.263774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T00:48:40.938554Z","caller":"traceutil/trace.go:171","msg":"trace[1883759296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:739; }","duration":"415.217835ms","start":"2026-04-16T00:48:40.523323Z","end":"2026-04-16T00:48:40.938541Z","steps":["trace[1883759296] 'range keys from in-memory index tree' (duration: 415.02794ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:48:40.938581Z","caller":"traceutil/trace.go:171","msg":"trace[899848761] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:739; }","duration":"414.367117ms","start":"2026-04-16T00:48:40.524196Z","end":"2026-04-16T00:48:40.938563Z","steps":["trace[899848761] 'range keys from in-memory index tree' (duration: 414.12823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:40.938614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:40.523303Z","time spent":"415.291498ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T00:48:40.938622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:40.524188Z","time spent":"414.42584ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T00:48:40.937883Z","caller":"traceutil/trace.go:171","msg":"trace[1283968135] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:739; }","duration":"441.846256ms","start":"2026-04-16T00:48:40.496018Z","end":"2026-04-16T00:48:40.937865Z","steps":["trace[1283968135] 'range keys from in-memory index tree' (duration: 441.450983ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:48:40.93871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:48:40.495999Z","time spent":"442.698134ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T00:50:28.680391Z","caller":"traceutil/trace.go:171","msg":"trace[346697409] transaction","detail":"{read_only:false; response_revision:1422; number_of_response:1; }","duration":"246.101398ms","start":"2026-04-16T00:50:28.434257Z","end":"2026-04-16T00:50:28.680358Z","steps":["trace[346697409] 'process raft request' (duration: 245.901553ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:33.683346Z","caller":"traceutil/trace.go:171","msg":"trace[732687673] linearizableReadLoop","detail":"{readStateIndex:1531; appliedIndex:1530; }","duration":"112.050074ms","start":"2026-04-16T00:50:33.57127Z","end":"2026-04-16T00:50:33.68332Z","steps":["trace[732687673] 'read index received' (duration: 111.812018ms)","trace[732687673] 'applied index is now lower than readState.Index' (duration: 237.146µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:50:33.683387Z","caller":"traceutil/trace.go:171","msg":"trace[77810241] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"119.522897ms","start":"2026-04-16T00:50:33.563818Z","end":"2026-04-16T00:50:33.683341Z","steps":["trace[77810241] 'process raft request' (duration: 119.352992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:33.683582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.293291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T00:50:33.683625Z","caller":"traceutil/trace.go:171","msg":"trace[1971311163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1478; }","duration":"112.395403ms","start":"2026-04-16T00:50:33.571218Z","end":"2026-04-16T00:50:33.683613Z","steps":["trace[1971311163] 'agreement among raft nodes before linearized reading' (duration: 112.238429ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:33.683638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.034995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T00:50:33.683696Z","caller":"traceutil/trace.go:171","msg":"trace[2037657944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1478; }","duration":"110.128548ms","start":"2026-04-16T00:50:33.573552Z","end":"2026-04-16T00:50:33.68368Z","steps":["trace[2037657944] 'agreement among raft nodes before linearized reading' (duration: 109.970124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:33.683905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.038195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T00:50:33.683949Z","caller":"traceutil/trace.go:171","msg":"trace[1173874499] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1478; }","duration":"110.120917ms","start":"2026-04-16T00:50:33.573817Z","end":"2026-04-16T00:50:33.683938Z","steps":["trace[1173874499] 'agreement among raft nodes before linearized reading' (duration: 109.974303ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:33.684451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.413895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T00:50:33.684639Z","caller":"traceutil/trace.go:171","msg":"trace[2025095984] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1478; }","duration":"110.66011ms","start":"2026-04-16T00:50:33.573945Z","end":"2026-04-16T00:50:33.684605Z","steps":["trace[2025095984] 'agreement among raft nodes before linearized reading' (duration: 109.850251ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:33.987418Z","caller":"traceutil/trace.go:171","msg":"trace[1912096560] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"298.97943ms","start":"2026-04-16T00:50:33.688407Z","end":"2026-04-16T00:50:33.987387Z","steps":["trace[1912096560] 'process raft request' (duration: 295.26449ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:34.473724Z","caller":"traceutil/trace.go:171","msg":"trace[1159657623] linearizableReadLoop","detail":"{readStateIndex:1535; appliedIndex:1531; }","duration":"568.640862ms","start":"2026-04-16T00:50:33.905051Z","end":"2026-04-16T00:50:34.473692Z","steps":["trace[1159657623] 'read index received' (duration: 78.624312ms)","trace[1159657623] 'applied index is now lower than readState.Index' (duration: 490.01512ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:50:34.47393Z","caller":"traceutil/trace.go:171","msg":"trace[363476021] transaction","detail":"{read_only:false; response_revision:1482; number_of_response:1; }","duration":"784.141723ms","start":"2026-04-16T00:50:33.689718Z","end":"2026-04-16T00:50:34.473859Z","steps":["trace[363476021] 'process raft request' (duration: 783.924957ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:34.474173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.095054ms","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":"info","ts":"2026-04-16T00:50:34.474209Z","caller":"traceutil/trace.go:171","msg":"trace[2141207977] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1482; }","duration":"569.162936ms","start":"2026-04-16T00:50:33.905035Z","end":"2026-04-16T00:50:34.474198Z","steps":["trace[2141207977] 'agreement among raft nodes before linearized reading' (duration: 568.834788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:34.474249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:33.905009Z","time spent":"569.232067ms","remote":"127.0.0.1:36658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-16T00:50:34.474322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:33.689701Z","time spent":"784.499192ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:50:34.474383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.151249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:50:34.474455Z","caller":"traceutil/trace.go:171","msg":"trace[39372277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1482; }","duration":"400.303013ms","start":"2026-04-16T00:50:34.074134Z","end":"2026-04-16T00:50:34.474437Z","steps":["trace[39372277] 'agreement among raft nodes before linearized reading' (duration: 400.170329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:34.474501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:34.074093Z","time spent":"400.401065ms","remote":"127.0.0.1:36316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T00:50:34.474517Z","caller":"traceutil/trace.go:171","msg":"trace[1846239730] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"784.875941ms","start":"2026-04-16T00:50:33.689627Z","end":"2026-04-16T00:50:34.474503Z","steps":["trace[1846239730] 'process raft request' (duration: 783.972589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:34.474599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:33.689607Z","time spent":"784.957363ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:50:34.474639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.669579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-16T00:50:34.47477Z","caller":"traceutil/trace.go:171","msg":"trace[1305775145] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1482; }","duration":"327.848753ms","start":"2026-04-16T00:50:34.146894Z","end":"2026-04-16T00:50:34.474743Z","steps":["trace[1305775145] 'agreement among raft nodes before linearized reading' (duration: 327.439443ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:34.474855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:34.146875Z","time spent":"327.968287ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-16T00:50:34.473862Z","caller":"traceutil/trace.go:171","msg":"trace[804616229] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"784.80869ms","start":"2026-04-16T00:50:33.689008Z","end":"2026-04-16T00:50:34.473817Z","steps":["trace[804616229] 'process raft request' (duration: 744.722421ms)","trace[804616229] 'compare' (duration: 39.673858ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:50:34.47544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:33.68898Z","time spent":"786.185672ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:50:40.775387Z","caller":"traceutil/trace.go:171","msg":"trace[1991343877] transaction","detail":"{read_only:false; response_revision:1616; number_of_response:1; }","duration":"271.002007ms","start":"2026-04-16T00:50:40.504355Z","end":"2026-04-16T00:50:40.775357Z","steps":["trace[1991343877] 'process raft request' (duration: 270.828723ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:40.780551Z","caller":"traceutil/trace.go:171","msg":"trace[2130228643] linearizableReadLoop","detail":"{readStateIndex:1671; appliedIndex:1669; }","duration":"273.245183ms","start":"2026-04-16T00:50:40.50728Z","end":"2026-04-16T00:50:40.780525Z","steps":["trace[2130228643] 'read index received' (duration: 268.031403ms)","trace[2130228643] 'applied index is now lower than readState.Index' (duration: 5.19957ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:50:40.780833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.53188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T00:50:40.78089Z","caller":"traceutil/trace.go:171","msg":"trace[446961247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1617; }","duration":"273.620892ms","start":"2026-04-16T00:50:40.507256Z","end":"2026-04-16T00:50:40.780876Z","steps":["trace[446961247] 'agreement among raft nodes before linearized reading' (duration: 273.450268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:40.780849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.885684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-cf56b6468-2q6rm\" ","response":"range_response_count:1 size:7980"} {"level":"warn","ts":"2026-04-16T00:50:40.780983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.855094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/cert-manager/cmapichecker-bfkzg\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:50:40.781069Z","caller":"traceutil/trace.go:171","msg":"trace[6085044] range","detail":"{range_begin:/registry/cert-manager.io/certificates/cert-manager/cmapichecker-bfkzg; range_end:; response_count:0; response_revision:1617; }","duration":"264.966696ms","start":"2026-04-16T00:50:40.516079Z","end":"2026-04-16T00:50:40.781045Z","steps":["trace[6085044] 'agreement among raft nodes before linearized reading' (duration: 264.815992ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:40.781035Z","caller":"traceutil/trace.go:171","msg":"trace[132085830] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-cf56b6468-2q6rm; range_end:; response_count:1; response_revision:1617; }","duration":"267.369936ms","start":"2026-04-16T00:50:40.513619Z","end":"2026-04-16T00:50:40.780989Z","steps":["trace[132085830] 'agreement among raft nodes before linearized reading' (duration: 267.105469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:40.781201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.485765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T00:50:40.781896Z","caller":"traceutil/trace.go:171","msg":"trace[111489950] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1617; }","duration":"265.278564ms","start":"2026-04-16T00:50:40.516602Z","end":"2026-04-16T00:50:40.781881Z","steps":["trace[111489950] 'agreement among raft nodes before linearized reading' (duration: 264.218748ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:40.782232Z","caller":"traceutil/trace.go:171","msg":"trace[1041654201] transaction","detail":"{read_only:false; response_revision:1617; number_of_response:1; }","duration":"273.463658ms","start":"2026-04-16T00:50:40.507152Z","end":"2026-04-16T00:50:40.780616Z","steps":["trace[1041654201] 'process raft request' (duration: 273.264433ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:40.91312Z","caller":"traceutil/trace.go:171","msg":"trace[1810011493] transaction","detail":"{read_only:false; response_revision:1620; number_of_response:1; }","duration":"122.319724ms","start":"2026-04-16T00:50:40.790773Z","end":"2026-04-16T00:50:40.913093Z","steps":["trace[1810011493] 'process raft request' (duration: 122.250392ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:40.913459Z","caller":"traceutil/trace.go:171","msg":"trace[1636173841] transaction","detail":"{read_only:false; response_revision:1619; number_of_response:1; }","duration":"127.713959ms","start":"2026-04-16T00:50:40.785698Z","end":"2026-04-16T00:50:40.913412Z","steps":["trace[1636173841] 'process raft request' (duration: 127.170676ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:41.064395Z","caller":"traceutil/trace.go:171","msg":"trace[1939383581] transaction","detail":"{read_only:false; response_revision:1621; number_of_response:1; }","duration":"138.036452ms","start":"2026-04-16T00:50:40.926325Z","end":"2026-04-16T00:50:41.064362Z","steps":["trace[1939383581] 'process raft request' (duration: 95.25682ms)","trace[1939383581] 'compare' (duration: 42.639468ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:50:41.268541Z","caller":"traceutil/trace.go:171","msg":"trace[1797779802] linearizableReadLoop","detail":"{readStateIndex:1676; appliedIndex:1675; }","duration":"196.184786ms","start":"2026-04-16T00:50:41.072316Z","end":"2026-04-16T00:50:41.268501Z","steps":["trace[1797779802] 'read index received' (duration: 188.454662ms)","trace[1797779802] 'applied index is now lower than readState.Index' (duration: 7.728854ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:50:41.268632Z","caller":"traceutil/trace.go:171","msg":"trace[1678546776] transaction","detail":"{read_only:false; response_revision:1622; number_of_response:1; }","duration":"196.337149ms","start":"2026-04-16T00:50:41.072266Z","end":"2026-04-16T00:50:41.268603Z","steps":["trace[1678546776] 'process raft request' (duration: 188.483853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:41.269169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.829622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-x54hg\" ","response":"range_response_count:1 size:4179"} {"level":"info","ts":"2026-04-16T00:50:41.269225Z","caller":"traceutil/trace.go:171","msg":"trace[1243718870] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-x54hg; range_end:; response_count:1; response_revision:1622; }","duration":"196.931194ms","start":"2026-04-16T00:50:41.072277Z","end":"2026-04-16T00:50:41.269208Z","steps":["trace[1243718870] 'agreement among raft nodes before linearized reading' (duration: 196.36027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:41.279185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.92983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:50:41.279266Z","caller":"traceutil/trace.go:171","msg":"trace[896314258] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1626; }","duration":"206.034123ms","start":"2026-04-16T00:50:41.073215Z","end":"2026-04-16T00:50:41.279249Z","steps":["trace[896314258] 'agreement among raft nodes before linearized reading' (duration: 205.89927ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:41.279964Z","caller":"traceutil/trace.go:171","msg":"trace[888415112] transaction","detail":"{read_only:false; response_revision:1623; number_of_response:1; }","duration":"207.627133ms","start":"2026-04-16T00:50:41.072321Z","end":"2026-04-16T00:50:41.279948Z","steps":["trace[888415112] 'process raft request' (duration: 206.529625ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:41.280288Z","caller":"traceutil/trace.go:171","msg":"trace[443765117] transaction","detail":"{read_only:false; response_revision:1626; number_of_response:1; }","duration":"203.53911ms","start":"2026-04-16T00:50:41.076735Z","end":"2026-04-16T00:50:41.280274Z","steps":["trace[443765117] 'process raft request' (duration: 202.326509ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:41.280405Z","caller":"traceutil/trace.go:171","msg":"trace[1644556308] transaction","detail":"{read_only:false; response_revision:1624; number_of_response:1; }","duration":"208.013872ms","start":"2026-04-16T00:50:41.07235Z","end":"2026-04-16T00:50:41.280364Z","steps":["trace[1644556308] 'process raft request' (duration: 206.626857ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:41.280603Z","caller":"traceutil/trace.go:171","msg":"trace[191948147] transaction","detail":"{read_only:false; response_revision:1625; number_of_response:1; }","duration":"207.339546ms","start":"2026-04-16T00:50:41.073255Z","end":"2026-04-16T00:50:41.280594Z","steps":["trace[191948147] 'process raft request' (duration: 205.761916ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:50:43.203435Z","caller":"traceutil/trace.go:171","msg":"trace[2133635056] linearizableReadLoop","detail":"{readStateIndex:1689; appliedIndex:1688; }","duration":"423.453264ms","start":"2026-04-16T00:50:42.779954Z","end":"2026-04-16T00:50:43.203407Z","steps":["trace[2133635056] 'read index received' (duration: 423.177757ms)","trace[2133635056] 'applied index is now lower than readState.Index' (duration: 274.627µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:50:43.203491Z","caller":"traceutil/trace.go:171","msg":"trace[1024887799] transaction","detail":"{read_only:false; response_revision:1634; number_of_response:1; }","duration":"602.526175ms","start":"2026-04-16T00:50:42.600941Z","end":"2026-04-16T00:50:43.203467Z","steps":["trace[1024887799] 'process raft request' (duration: 602.3079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:43.203615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:42.600916Z","time spent":"602.624718ms","remote":"127.0.0.1:36590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3148,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:50:43.203767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.504289ms","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-04-16T00:50:43.203661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.704281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T00:50:43.203817Z","caller":"traceutil/trace.go:171","msg":"trace[46224843] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1634; }","duration":"416.592142ms","start":"2026-04-16T00:50:42.787213Z","end":"2026-04-16T00:50:43.203805Z","steps":["trace[46224843] 'agreement among raft nodes before linearized reading' (duration: 416.476769ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:43.20385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:42.787193Z","time spent":"416.650613ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T00:50:43.20388Z","caller":"traceutil/trace.go:171","msg":"trace[1022695470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1634; }","duration":"423.917746ms","start":"2026-04-16T00:50:42.779897Z","end":"2026-04-16T00:50:43.203815Z","steps":["trace[1022695470] 'agreement among raft nodes before linearized reading' (duration: 423.644959ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:43.203926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.584573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-16T00:50:43.204008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.46628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T00:50:43.204021Z","caller":"traceutil/trace.go:171","msg":"trace[1253597814] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1634; }","duration":"286.724247ms","start":"2026-04-16T00:50:42.91728Z","end":"2026-04-16T00:50:43.204004Z","steps":["trace[1253597814] 'agreement among raft nodes before linearized reading' (duration: 286.536832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:43.204023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:42.779874Z","time spent":"424.129062ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-16T00:50:43.204109Z","caller":"traceutil/trace.go:171","msg":"trace[94057052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1634; }","duration":"354.561462ms","start":"2026-04-16T00:50:42.84949Z","end":"2026-04-16T00:50:43.204051Z","steps":["trace[94057052] 'agreement among raft nodes before linearized reading' (duration: 354.416998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:50:43.20399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.932194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:50:43.20415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:50:42.84947Z","time spent":"354.672514ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T00:50:43.204173Z","caller":"traceutil/trace.go:171","msg":"trace[1769612975] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1634; }","duration":"131.155428ms","start":"2026-04-16T00:50:43.072993Z","end":"2026-04-16T00:50:43.204148Z","steps":["trace[1769612975] 'agreement among raft nodes before linearized reading' (duration: 130.924012ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:04.13399Z","caller":"traceutil/trace.go:171","msg":"trace[109872781] transaction","detail":"{read_only:false; response_revision:2168; number_of_response:1; }","duration":"468.521974ms","start":"2026-04-16T00:51:03.665437Z","end":"2026-04-16T00:51:04.133959Z","steps":["trace[109872781] 'process raft request' (duration: 468.286028ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:04.134219Z","caller":"traceutil/trace.go:171","msg":"trace[2128531401] transaction","detail":"{read_only:false; response_revision:2170; number_of_response:1; }","duration":"459.575765ms","start":"2026-04-16T00:51:03.674614Z","end":"2026-04-16T00:51:04.13419Z","steps":["trace[2128531401] 'process raft request' (duration: 459.341449ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:04.134026Z","caller":"traceutil/trace.go:171","msg":"trace[382692000] transaction","detail":"{read_only:false; response_revision:2169; number_of_response:1; }","duration":"465.133863ms","start":"2026-04-16T00:51:03.668872Z","end":"2026-04-16T00:51:04.134006Z","steps":["trace[382692000] 'process raft request' (duration: 465.00788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.134396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:03.674606Z","time spent":"459.673369ms","remote":"127.0.0.1:32782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7769,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:04.134481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:03.668864Z","time spent":"465.542455ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10970,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:04.135177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:03.665429Z","time spent":"468.824402ms","remote":"127.0.0.1:36400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T00:51:04.154838Z","caller":"traceutil/trace.go:171","msg":"trace[139822079] linearizableReadLoop","detail":"{readStateIndex:2259; appliedIndex:2255; }","duration":"364.701247ms","start":"2026-04-16T00:51:03.790119Z","end":"2026-04-16T00:51:04.15482Z","steps":["trace[139822079] 'read index received' (duration: 343.586672ms)","trace[139822079] 'applied index is now lower than readState.Index' (duration: 21.113815ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:04.154906Z","caller":"traceutil/trace.go:171","msg":"trace[200709383] transaction","detail":"{read_only:false; response_revision:2171; number_of_response:1; }","duration":"383.557959ms","start":"2026-04-16T00:51:03.771341Z","end":"2026-04-16T00:51:04.154899Z","steps":["trace[200709383] 'process raft request' (duration: 383.381144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.154979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:03.771315Z","time spent":"383.611701ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:04.155177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.036976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-16T00:51:04.15529Z","caller":"traceutil/trace.go:171","msg":"trace[155400024] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb; range_end:; response_count:1; response_revision:2171; }","duration":"365.182579ms","start":"2026-04-16T00:51:03.790087Z","end":"2026-04-16T00:51:04.15527Z","steps":["trace[155400024] 'agreement among raft nodes before linearized reading' (duration: 364.903741ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.155484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:03.790075Z","time spent":"365.395535ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3651,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb\" "} {"level":"info","ts":"2026-04-16T00:51:04.325817Z","caller":"traceutil/trace.go:171","msg":"trace[1436397411] linearizableReadLoop","detail":"{readStateIndex:2263; appliedIndex:2259; }","duration":"170.91096ms","start":"2026-04-16T00:51:04.154879Z","end":"2026-04-16T00:51:04.32579Z","steps":["trace[1436397411] 'read index received' (duration: 79.809454ms)","trace[1436397411] 'applied index is now lower than readState.Index' (duration: 91.099996ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:04.325846Z","caller":"traceutil/trace.go:171","msg":"trace[1706521631] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"185.869699ms","start":"2026-04-16T00:51:04.139936Z","end":"2026-04-16T00:51:04.325806Z","steps":["trace[1706521631] 'process raft request' (duration: 184.40702ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:04.325956Z","caller":"traceutil/trace.go:171","msg":"trace[1549586171] transaction","detail":"{read_only:false; response_revision:2172; number_of_response:1; }","duration":"187.456442ms","start":"2026-04-16T00:51:04.138475Z","end":"2026-04-16T00:51:04.325931Z","steps":["trace[1549586171] 'process raft request' (duration: 96.256243ms)","trace[1549586171] 'compare' (duration: 89.284477ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:04.325937Z","caller":"traceutil/trace.go:171","msg":"trace[1763669998] transaction","detail":"{read_only:false; response_revision:2173; number_of_response:1; }","duration":"186.120636ms","start":"2026-04-16T00:51:04.139782Z","end":"2026-04-16T00:51:04.325902Z","steps":["trace[1763669998] 'process raft request' (duration: 184.476132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.32611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.90213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/valkey-server-certs\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:04.328578Z","caller":"traceutil/trace.go:171","msg":"trace[1035107662] range","detail":"{range_begin:/registry/secrets/openstack/valkey-server-certs; range_end:; response_count:0; response_revision:2175; }","duration":"188.438267ms","start":"2026-04-16T00:51:04.140113Z","end":"2026-04-16T00:51:04.328552Z","steps":["trace[1035107662] 'agreement among raft nodes before linearized reading' (duration: 185.866139ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:04.326278Z","caller":"traceutil/trace.go:171","msg":"trace[1673850264] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"186.227139ms","start":"2026-04-16T00:51:04.140033Z","end":"2026-04-16T00:51:04.32626Z","steps":["trace[1673850264] 'process raft request' (duration: 184.446222ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.32645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.097334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-16T00:51:04.329006Z","caller":"traceutil/trace.go:171","msg":"trace[807226028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2175; }","duration":"213.685483ms","start":"2026-04-16T00:51:04.115299Z","end":"2026-04-16T00:51:04.328985Z","steps":["trace[807226028] 'agreement among raft nodes before linearized reading' (duration: 211.024382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.326495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.243853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-16T00:51:04.329244Z","caller":"traceutil/trace.go:171","msg":"trace[262471586] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb; range_end:; response_count:1; response_revision:2175; }","duration":"191.048538ms","start":"2026-04-16T00:51:04.138184Z","end":"2026-04-16T00:51:04.329233Z","steps":["trace[262471586] 'agreement among raft nodes before linearized reading' (duration: 188.1534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.326527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.6552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:04.329403Z","caller":"traceutil/trace.go:171","msg":"trace[1121318073] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2175; }","duration":"256.569958ms","start":"2026-04-16T00:51:04.072826Z","end":"2026-04-16T00:51:04.329396Z","steps":["trace[1121318073] 'agreement among raft nodes before linearized reading' (duration: 253.668101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.3269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.315167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d8518d63-1c06-4c5c-b880-cec13275ba49\" ","response":"range_response_count:1 size:3617"} {"level":"info","ts":"2026-04-16T00:51:04.32952Z","caller":"traceutil/trace.go:171","msg":"trace[1133396579] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d8518d63-1c06-4c5c-b880-cec13275ba49; range_end:; response_count:1; response_revision:2175; }","duration":"444.979548ms","start":"2026-04-16T00:51:03.88452Z","end":"2026-04-16T00:51:04.3295Z","steps":["trace[1133396579] 'agreement among raft nodes before linearized reading' (duration: 442.211984ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:04.329629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:03.884502Z","time spent":"445.107382ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3641,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d8518d63-1c06-4c5c-b880-cec13275ba49\" "} {"level":"warn","ts":"2026-04-16T00:51:04.327405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.467278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:04.329697Z","caller":"traceutil/trace.go:171","msg":"trace[616676967] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2175; }","duration":"129.777999ms","start":"2026-04-16T00:51:04.199897Z","end":"2026-04-16T00:51:04.329675Z","steps":["trace[616676967] 'agreement among raft nodes before linearized reading' (duration: 127.390186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.040739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.74246ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T00:51:05.04095Z","caller":"traceutil/trace.go:171","msg":"trace[1067845394] transaction","detail":"{read_only:false; response_revision:2176; number_of_response:1; }","duration":"706.795328ms","start":"2026-04-16T00:51:04.334123Z","end":"2026-04-16T00:51:05.040918Z","steps":["trace[1067845394] 'process raft request' (duration: 135.815581ms)","trace[1067845394] 'compare' (duration: 569.883338ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:51:05.041136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.334101Z","time spent":"706.937431ms","remote":"127.0.0.1:36430","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5391,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:05.041654Z","caller":"traceutil/trace.go:171","msg":"trace[2028512561] transaction","detail":"{read_only:false; response_revision:2177; number_of_response:1; }","duration":"706.88105ms","start":"2026-04-16T00:51:04.334745Z","end":"2026-04-16T00:51:05.041626Z","steps":["trace[2028512561] 'process raft request' (duration: 706.094729ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:05.041775Z","caller":"traceutil/trace.go:171","msg":"trace[1362695706] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"705.595975ms","start":"2026-04-16T00:51:04.336155Z","end":"2026-04-16T00:51:05.041751Z","steps":["trace[1362695706] 'process raft request' (duration: 704.775713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.041858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.336148Z","time spent":"705.673478ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3732,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:05.041937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.334739Z","time spent":"707.030644ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:05.721434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.793377ms","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-04-16T00:51:05.721562Z","caller":"traceutil/trace.go:171","msg":"trace[1530079848] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2178; }","duration":"338.933092ms","start":"2026-04-16T00:51:05.382612Z","end":"2026-04-16T00:51:05.721545Z","steps":["trace[1530079848] 'range keys from in-memory index tree' (duration: 338.779907ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:05.736661Z","caller":"traceutil/trace.go:171","msg":"trace[1009963863] linearizableReadLoop","detail":"{readStateIndex:2267; appliedIndex:2263; }","duration":"1.029849056s","start":"2026-04-16T00:51:04.706789Z","end":"2026-04-16T00:51:05.736638Z","steps":["trace[1009963863] 'read index received' (duration: 204.457967ms)","trace[1009963863] 'applied index is now lower than readState.Index' (duration: 825.390089ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:05.736668Z","caller":"traceutil/trace.go:171","msg":"trace[1702371622] transaction","detail":"{read_only:false; response_revision:2179; number_of_response:1; }","duration":"1.235853083s","start":"2026-04-16T00:51:04.500786Z","end":"2026-04-16T00:51:05.736639Z","steps":["trace[1702371622] 'process raft request' (duration: 1.235626287s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.736817Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.500761Z","time spent":"1.235991916s","remote":"127.0.0.1:36400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":940,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T00:51:05.736929Z","caller":"traceutil/trace.go:171","msg":"trace[789512042] transaction","detail":"{read_only:false; response_revision:2181; number_of_response:1; }","duration":"976.804238ms","start":"2026-04-16T00:51:04.760081Z","end":"2026-04-16T00:51:05.736885Z","steps":["trace[789512042] 'process raft request' (duration: 976.52122ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.736997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.030195725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:05.737034Z","caller":"traceutil/trace.go:171","msg":"trace[732613525] transaction","detail":"{read_only:false; response_revision:2180; number_of_response:1; }","duration":"987.442212ms","start":"2026-04-16T00:51:04.749568Z","end":"2026-04-16T00:51:05.73701Z","steps":["trace[732613525] 'process raft request' (duration: 986.9721ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:05.737049Z","caller":"traceutil/trace.go:171","msg":"trace[1213843024] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2181; }","duration":"1.030286058s","start":"2026-04-16T00:51:04.706749Z","end":"2026-04-16T00:51:05.737035Z","steps":["trace[1213843024] 'agreement among raft nodes before linearized reading' (duration: 1.030170825s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.737061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.760033Z","time spent":"976.960922ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:05.737093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.706733Z","time spent":"1.030350139s","remote":"127.0.0.1:60346","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-16T00:51:05.737166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.749544Z","time spent":"987.536995ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:05.747915Z","caller":"traceutil/trace.go:171","msg":"trace[1270927165] transaction","detail":"{read_only:false; response_revision:2182; number_of_response:1; }","duration":"688.271852ms","start":"2026-04-16T00:51:05.059632Z","end":"2026-04-16T00:51:05.747904Z","steps":["trace[1270927165] 'process raft request' (duration: 688.19409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.747994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.059614Z","time spent":"688.332373ms","remote":"127.0.0.1:32778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2233,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:05.748228Z","caller":"traceutil/trace.go:171","msg":"trace[269836532] transaction","detail":"{read_only:false; number_of_response:1; response_revision:2182; }","duration":"687.366148ms","start":"2026-04-16T00:51:05.060844Z","end":"2026-04-16T00:51:05.748211Z","steps":["trace[269836532] 'process raft request' (duration: 687.039599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.7483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.060835Z","time spent":"687.426699ms","remote":"127.0.0.1:32778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":66,"response count":0,"response size":2283,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:05.748438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"774.951672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:51:05.748505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.393518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T00:51:05.748523Z","caller":"traceutil/trace.go:171","msg":"trace[3394484] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2184; }","duration":"775.081066ms","start":"2026-04-16T00:51:04.973429Z","end":"2026-04-16T00:51:05.74851Z","steps":["trace[3394484] 'agreement among raft nodes before linearized reading' (duration: 774.930602ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:05.748545Z","caller":"traceutil/trace.go:171","msg":"trace[748601341] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2184; }","duration":"397.454219ms","start":"2026-04-16T00:51:05.35108Z","end":"2026-04-16T00:51:05.748534Z","steps":["trace[748601341] 'agreement among raft nodes before linearized reading' (duration: 397.319726ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.748567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.97341Z","time spent":"775.145458ms","remote":"127.0.0.1:60336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"info","ts":"2026-04-16T00:51:05.748619Z","caller":"traceutil/trace.go:171","msg":"trace[855898470] transaction","detail":"{read_only:false; response_revision:2183; number_of_response:1; }","duration":"462.379289ms","start":"2026-04-16T00:51:05.286231Z","end":"2026-04-16T00:51:05.74861Z","steps":["trace[855898470] 'process raft request' (duration: 461.936997ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.748665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.910959ms","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-04-16T00:51:05.748678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.28621Z","time spent":"462.43748ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:05.748694Z","caller":"traceutil/trace.go:171","msg":"trace[672662838] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2184; }","duration":"398.95773ms","start":"2026-04-16T00:51:05.349729Z","end":"2026-04-16T00:51:05.748687Z","steps":["trace[672662838] 'agreement among raft nodes before linearized reading' (duration: 398.857568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.748714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.349718Z","time spent":"398.991321ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-16T00:51:05.748779Z","caller":"traceutil/trace.go:171","msg":"trace[1552957627] transaction","detail":"{read_only:false; response_revision:2184; number_of_response:1; }","duration":"289.196458ms","start":"2026-04-16T00:51:05.459574Z","end":"2026-04-16T00:51:05.74877Z","steps":["trace[1552957627] 'process raft request' (duration: 288.712546ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.748786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.90957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d8518d63-1c06-4c5c-b880-cec13275ba49\" ","response":"range_response_count:1 size:3617"} {"level":"warn","ts":"2026-04-16T00:51:05.74895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.635256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-16T00:51:05.74899Z","caller":"traceutil/trace.go:171","msg":"trace[976784437] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb; range_end:; response_count:1; response_revision:2184; }","duration":"699.671407ms","start":"2026-04-16T00:51:05.049307Z","end":"2026-04-16T00:51:05.748979Z","steps":["trace[976784437] 'agreement among raft nodes before linearized reading' (duration: 699.584515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.74902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.049265Z","time spent":"699.749289ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3771,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb\" "} {"level":"warn","ts":"2026-04-16T00:51:05.749026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.720236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T00:51:05.749055Z","caller":"traceutil/trace.go:171","msg":"trace[78729100] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2184; }","duration":"394.772568ms","start":"2026-04-16T00:51:05.354274Z","end":"2026-04-16T00:51:05.749046Z","steps":["trace[78729100] 'agreement among raft nodes before linearized reading' (duration: 394.695236ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.749076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.136728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-16T00:51:05.749095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.354256Z","time spent":"394.828909ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T00:51:05.749099Z","caller":"traceutil/trace.go:171","msg":"trace[2135816277] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2184; }","duration":"395.204399ms","start":"2026-04-16T00:51:05.353888Z","end":"2026-04-16T00:51:05.749093Z","steps":["trace[2135816277] 'agreement among raft nodes before linearized reading' (duration: 395.142037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.749121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.353869Z","time spent":"395.24854ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T00:51:05.749168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.752742ms","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":"warn","ts":"2026-04-16T00:51:05.749202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.758013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:05.749204Z","caller":"traceutil/trace.go:171","msg":"trace[2011938229] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2184; }","duration":"754.826174ms","start":"2026-04-16T00:51:04.99437Z","end":"2026-04-16T00:51:05.749196Z","steps":["trace[2011938229] 'agreement among raft nodes before linearized reading' (duration: 754.773602ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:05.74922Z","caller":"traceutil/trace.go:171","msg":"trace[2139459603] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2184; }","duration":"411.806824ms","start":"2026-04-16T00:51:05.337406Z","end":"2026-04-16T00:51:05.749213Z","steps":["trace[2139459603] 'agreement among raft nodes before linearized reading' (duration: 411.758413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.749236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.337383Z","time spent":"411.849505ms","remote":"127.0.0.1:51890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-16T00:51:05.749238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:04.994345Z","time spent":"754.885596ms","remote":"127.0.0.1:36654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":31,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"info","ts":"2026-04-16T00:51:05.748972Z","caller":"traceutil/trace.go:171","msg":"trace[302939426] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d8518d63-1c06-4c5c-b880-cec13275ba49; range_end:; response_count:1; response_revision:2184; }","duration":"414.122436ms","start":"2026-04-16T00:51:05.334774Z","end":"2026-04-16T00:51:05.748897Z","steps":["trace[302939426] 'agreement among raft nodes before linearized reading' (duration: 413.631893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.748578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.35107Z","time spent":"397.501911ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T00:51:05.749459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.334755Z","time spent":"414.609109ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3641,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d8518d63-1c06-4c5c-b880-cec13275ba49\" "} {"level":"warn","ts":"2026-04-16T00:51:05.74887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.611448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb\" ","response":"range_response_count:1 size:3747"} {"level":"info","ts":"2026-04-16T00:51:05.749584Z","caller":"traceutil/trace.go:171","msg":"trace[1804655568] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb; range_end:; response_count:1; response_revision:2184; }","duration":"590.356898ms","start":"2026-04-16T00:51:05.159218Z","end":"2026-04-16T00:51:05.749575Z","steps":["trace[1804655568] 'agreement among raft nodes before linearized reading' (duration: 589.519146ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:05.749613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:05.159203Z","time spent":"590.401489ms","remote":"127.0.0.1:36528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3771,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5bfa629c-9b4f-4169-b9eb-3f374a37e5bb\" "} {"level":"info","ts":"2026-04-16T00:51:11.207247Z","caller":"traceutil/trace.go:171","msg":"trace[1977131808] linearizableReadLoop","detail":"{readStateIndex:2348; appliedIndex:2347; }","duration":"134.360236ms","start":"2026-04-16T00:51:11.072867Z","end":"2026-04-16T00:51:11.207227Z","steps":["trace[1977131808] 'read index received' (duration: 134.184351ms)","trace[1977131808] 'applied index is now lower than readState.Index' (duration: 175.065µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:51:11.207365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.479779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:11.207404Z","caller":"traceutil/trace.go:171","msg":"trace[219160698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2256; }","duration":"134.547491ms","start":"2026-04-16T00:51:11.072843Z","end":"2026-04-16T00:51:11.207391Z","steps":["trace[219160698] 'agreement among raft nodes before linearized reading' (duration: 134.466089ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:11.207408Z","caller":"traceutil/trace.go:171","msg":"trace[347816764] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"135.355623ms","start":"2026-04-16T00:51:11.072003Z","end":"2026-04-16T00:51:11.207359Z","steps":["trace[347816764] 'process raft request' (duration: 135.110846ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:14.399144Z","caller":"traceutil/trace.go:171","msg":"trace[636708360] linearizableReadLoop","detail":"{readStateIndex:2371; appliedIndex:2370; }","duration":"173.856395ms","start":"2026-04-16T00:51:14.225266Z","end":"2026-04-16T00:51:14.399123Z","steps":["trace[636708360] 'read index received' (duration: 173.693011ms)","trace[636708360] 'applied index is now lower than readState.Index' (duration: 162.334µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:51:14.399264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.972928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T00:51:14.399301Z","caller":"traceutil/trace.go:171","msg":"trace[956397506] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:2278; }","duration":"174.0291ms","start":"2026-04-16T00:51:14.225261Z","end":"2026-04-16T00:51:14.39929Z","steps":["trace[956397506] 'agreement among raft nodes before linearized reading' (duration: 173.947568ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:14.399386Z","caller":"traceutil/trace.go:171","msg":"trace[1467062341] transaction","detail":"{read_only:false; response_revision:2278; number_of_response:1; }","duration":"213.283071ms","start":"2026-04-16T00:51:14.186065Z","end":"2026-04-16T00:51:14.399348Z","steps":["trace[1467062341] 'process raft request' (duration: 212.911641ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:19.964773Z","caller":"traceutil/trace.go:171","msg":"trace[704687565] transaction","detail":"{read_only:false; response_revision:2315; number_of_response:1; }","duration":"179.676409ms","start":"2026-04-16T00:51:19.785071Z","end":"2026-04-16T00:51:19.964748Z","steps":["trace[704687565] 'process raft request' (duration: 179.405851ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:19.965147Z","caller":"traceutil/trace.go:171","msg":"trace[485120950] linearizableReadLoop","detail":"{readStateIndex:2411; appliedIndex:2408; }","duration":"146.544626ms","start":"2026-04-16T00:51:19.818582Z","end":"2026-04-16T00:51:19.965126Z","steps":["trace[485120950] 'read index received' (duration: 145.124737ms)","trace[485120950] 'applied index is now lower than readState.Index' (duration: 1.418929ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:19.965253Z","caller":"traceutil/trace.go:171","msg":"trace[1866926304] transaction","detail":"{read_only:false; response_revision:2317; number_of_response:1; }","duration":"178.714082ms","start":"2026-04-16T00:51:19.786526Z","end":"2026-04-16T00:51:19.96524Z","steps":["trace[1866926304] 'process raft request' (duration: 178.505597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:19.965475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.415476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:19.965519Z","caller":"traceutil/trace.go:171","msg":"trace[369770181] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2317; }","duration":"124.508799ms","start":"2026-04-16T00:51:19.840995Z","end":"2026-04-16T00:51:19.965503Z","steps":["trace[369770181] 'agreement among raft nodes before linearized reading' (duration: 124.383575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:19.965469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.994059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-16T00:51:19.965734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.156873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T00:51:19.965737Z","caller":"traceutil/trace.go:171","msg":"trace[327940328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2317; }","duration":"143.292977ms","start":"2026-04-16T00:51:19.822422Z","end":"2026-04-16T00:51:19.965715Z","steps":["trace[327940328] 'agreement among raft nodes before linearized reading' (duration: 142.889865ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:19.965763Z","caller":"traceutil/trace.go:171","msg":"trace[1071474808] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2317; }","duration":"147.210365ms","start":"2026-04-16T00:51:19.818544Z","end":"2026-04-16T00:51:19.965754Z","steps":["trace[1071474808] 'agreement among raft nodes before linearized reading' (duration: 147.125202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:19.965912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.277609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T00:51:19.965253Z","caller":"traceutil/trace.go:171","msg":"trace[1303394853] transaction","detail":"{read_only:false; response_revision:2316; number_of_response:1; }","duration":"178.702962ms","start":"2026-04-16T00:51:19.786523Z","end":"2026-04-16T00:51:19.965226Z","steps":["trace[1303394853] 'process raft request' (duration: 178.181908ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:19.965965Z","caller":"traceutil/trace.go:171","msg":"trace[1905728525] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2317; }","duration":"138.356581ms","start":"2026-04-16T00:51:19.827595Z","end":"2026-04-16T00:51:19.965952Z","steps":["trace[1905728525] 'agreement among raft nodes before linearized reading' (duration: 137.907499ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:19.966088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.720604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:19.96616Z","caller":"traceutil/trace.go:171","msg":"trace[1939160332] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2317; }","duration":"100.823647ms","start":"2026-04-16T00:51:19.865314Z","end":"2026-04-16T00:51:19.966138Z","steps":["trace[1939160332] 'agreement among raft nodes before linearized reading' (duration: 100.440527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:19.966275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.847984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T00:51:19.967046Z","caller":"traceutil/trace.go:171","msg":"trace[1366139002] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2317; }","duration":"138.975438ms","start":"2026-04-16T00:51:19.827347Z","end":"2026-04-16T00:51:19.966322Z","steps":["trace[1366139002] 'agreement among raft nodes before linearized reading' (duration: 138.333851ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:22.110284Z","caller":"traceutil/trace.go:171","msg":"trace[32997923] transaction","detail":"{read_only:false; response_revision:2324; number_of_response:1; }","duration":"138.857482ms","start":"2026-04-16T00:51:21.971403Z","end":"2026-04-16T00:51:22.110261Z","steps":["trace[32997923] 'process raft request' (duration: 138.688137ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:22.643249Z","caller":"traceutil/trace.go:171","msg":"trace[1515369424] linearizableReadLoop","detail":"{readStateIndex:2420; appliedIndex:2417; }","duration":"669.332596ms","start":"2026-04-16T00:51:21.97389Z","end":"2026-04-16T00:51:22.643222Z","steps":["trace[1515369424] 'read index received' (duration: 136.223299ms)","trace[1515369424] 'applied index is now lower than readState.Index' (duration: 533.095497ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:22.64332Z","caller":"traceutil/trace.go:171","msg":"trace[284316448] transaction","detail":"{read_only:false; response_revision:2325; number_of_response:1; }","duration":"671.412945ms","start":"2026-04-16T00:51:21.971848Z","end":"2026-04-16T00:51:22.643261Z","steps":["trace[284316448] 'process raft request' (duration: 671.140077ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:22.643323Z","caller":"traceutil/trace.go:171","msg":"trace[1732889624] transaction","detail":"{read_only:false; response_revision:2326; number_of_response:1; }","duration":"669.551263ms","start":"2026-04-16T00:51:21.973726Z","end":"2026-04-16T00:51:22.643278Z","steps":["trace[1732889624] 'process raft request' (duration: 669.43575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.643563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.665656ms","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-04-16T00:51:22.643576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:21.971816Z","time spent":"671.564229ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:22.643553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:21.973713Z","time spent":"669.676596ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:22.643607Z","caller":"traceutil/trace.go:171","msg":"trace[542446900] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2326; }","duration":"669.779629ms","start":"2026-04-16T00:51:21.973817Z","end":"2026-04-16T00:51:22.643597Z","steps":["trace[542446900] 'agreement among raft nodes before linearized reading' (duration: 669.536492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.643675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:21.97379Z","time spent":"669.874512ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T00:51:22.677465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.045282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:22.677521Z","caller":"traceutil/trace.go:171","msg":"trace[1720922685] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2327; }","duration":"604.149895ms","start":"2026-04-16T00:51:22.073357Z","end":"2026-04-16T00:51:22.677507Z","steps":["trace[1720922685] 'agreement among raft nodes before linearized reading' (duration: 604.051132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.677514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.277141ms","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-04-16T00:51:22.677549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:22.07334Z","time spent":"604.203726ms","remote":"127.0.0.1:36316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T00:51:22.677564Z","caller":"traceutil/trace.go:171","msg":"trace[1065629755] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2327; }","duration":"701.373624ms","start":"2026-04-16T00:51:21.976174Z","end":"2026-04-16T00:51:22.677547Z","steps":["trace[1065629755] 'agreement among raft nodes before linearized reading' (duration: 701.186809ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.677618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:21.97616Z","time spent":"701.450686ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T00:51:22.677613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.979997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.238\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T00:51:22.677711Z","caller":"traceutil/trace.go:171","msg":"trace[1934145796] range","detail":"{range_begin:/registry/masterleases/199.204.45.238; range_end:; response_count:1; response_revision:2327; }","duration":"208.129812ms","start":"2026-04-16T00:51:22.469568Z","end":"2026-04-16T00:51:22.677698Z","steps":["trace[1934145796] 'agreement among raft nodes before linearized reading' (duration: 207.914276ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:22.677479Z","caller":"traceutil/trace.go:171","msg":"trace[55742381] transaction","detail":"{read_only:false; response_revision:2327; number_of_response:1; }","duration":"251.346858ms","start":"2026-04-16T00:51:22.426104Z","end":"2026-04-16T00:51:22.67745Z","steps":["trace[55742381] 'process raft request' (duration: 251.115602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.677869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.275863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T00:51:22.678077Z","caller":"traceutil/trace.go:171","msg":"trace[1582557493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2327; }","duration":"700.51924ms","start":"2026-04-16T00:51:21.977542Z","end":"2026-04-16T00:51:22.678061Z","steps":["trace[1582557493] 'agreement among raft nodes before linearized reading' (duration: 700.224772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.678127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:21.977523Z","time spent":"700.590082ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-16T00:51:22.678098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.558741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:22.678201Z","caller":"traceutil/trace.go:171","msg":"trace[571578198] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2327; }","duration":"696.721125ms","start":"2026-04-16T00:51:21.981453Z","end":"2026-04-16T00:51:22.678174Z","steps":["trace[571578198] 'agreement among raft nodes before linearized reading' (duration: 696.079567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.678304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:21.981419Z","time spent":"696.864839ms","remote":"127.0.0.1:51890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-16T00:51:22.678332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.515437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-16T00:51:22.678402Z","caller":"traceutil/trace.go:171","msg":"trace[1884681651] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2327; }","duration":"693.604529ms","start":"2026-04-16T00:51:21.984785Z","end":"2026-04-16T00:51:22.678369Z","steps":["trace[1884681651] 'agreement among raft nodes before linearized reading' (duration: 693.429664ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:22.678466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:21.984776Z","time spent":"693.65795ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-16T00:51:22.814813Z","caller":"traceutil/trace.go:171","msg":"trace[388515891] transaction","detail":"{read_only:false; response_revision:2331; number_of_response:1; }","duration":"131.163661ms","start":"2026-04-16T00:51:22.683622Z","end":"2026-04-16T00:51:22.814785Z","steps":["trace[388515891] 'process raft request' (duration: 131.12534ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:22.814891Z","caller":"traceutil/trace.go:171","msg":"trace[1068243412] transaction","detail":"{read_only:false; response_revision:2329; number_of_response:1; }","duration":"132.665663ms","start":"2026-04-16T00:51:22.682184Z","end":"2026-04-16T00:51:22.814849Z","steps":["trace[1068243412] 'process raft request' (duration: 132.398125ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:22.815025Z","caller":"traceutil/trace.go:171","msg":"trace[1914389669] transaction","detail":"{read_only:false; response_revision:2330; number_of_response:1; }","duration":"132.55491ms","start":"2026-04-16T00:51:22.682439Z","end":"2026-04-16T00:51:22.814994Z","steps":["trace[1914389669] 'process raft request' (duration: 132.265412ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:23.629566Z","caller":"traceutil/trace.go:171","msg":"trace[510148522] linearizableReadLoop","detail":"{readStateIndex:2428; appliedIndex:2427; }","duration":"323.898681ms","start":"2026-04-16T00:51:23.305641Z","end":"2026-04-16T00:51:23.62954Z","steps":["trace[510148522] 'read index received' (duration: 323.701236ms)","trace[510148522] 'applied index is now lower than readState.Index' (duration: 196.505µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:23.629609Z","caller":"traceutil/trace.go:171","msg":"trace[1306387811] transaction","detail":"{read_only:false; response_revision:2333; number_of_response:1; }","duration":"428.668446ms","start":"2026-04-16T00:51:23.200907Z","end":"2026-04-16T00:51:23.629575Z","steps":["trace[1306387811] 'process raft request' (duration: 428.44117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:23.62976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:23.200879Z","time spent":"428.81086ms","remote":"127.0.0.1:36400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":806,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T00:51:23.630871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.397602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:23.631112Z","caller":"traceutil/trace.go:171","msg":"trace[500867060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2333; }","duration":"224.69447ms","start":"2026-04-16T00:51:23.406398Z","end":"2026-04-16T00:51:23.631092Z","steps":["trace[500867060] 'agreement among raft nodes before linearized reading' (duration: 223.293831ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:23.631615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.972929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-16T00:51:23.631758Z","caller":"traceutil/trace.go:171","msg":"trace[208338515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2333; }","duration":"326.131613ms","start":"2026-04-16T00:51:23.305598Z","end":"2026-04-16T00:51:23.63173Z","steps":["trace[208338515] 'agreement among raft nodes before linearized reading' (duration: 324.090596ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:23.631907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:23.30558Z","time spent":"326.308618ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T00:51:23.836319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.224745ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T00:51:23.836456Z","caller":"traceutil/trace.go:171","msg":"trace[280412403] linearizableReadLoop","detail":"{readStateIndex:2429; appliedIndex:2428; }","duration":"149.589668ms","start":"2026-04-16T00:51:23.686842Z","end":"2026-04-16T00:51:23.836431Z","steps":["trace[280412403] 'read index received' (duration: 71.862µs)","trace[280412403] 'applied index is now lower than readState.Index' (duration: 149.516016ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:23.836496Z","caller":"traceutil/trace.go:171","msg":"trace[653382395] transaction","detail":"{read_only:false; response_revision:2334; number_of_response:1; }","duration":"197.721373ms","start":"2026-04-16T00:51:23.638744Z","end":"2026-04-16T00:51:23.836466Z","steps":["trace[653382395] 'process raft request' (duration: 20.19777ms)","trace[653382395] 'compare' (duration: 177.031859ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:51:23.836645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.408029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:23.836707Z","caller":"traceutil/trace.go:171","msg":"trace[2142221173] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2334; }","duration":"120.504872ms","start":"2026-04-16T00:51:23.716179Z","end":"2026-04-16T00:51:23.836684Z","steps":["trace[2142221173] 'agreement among raft nodes before linearized reading' (duration: 120.407089ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:23.836735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.893696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:23.836784Z","caller":"traceutil/trace.go:171","msg":"trace[1293186770] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2334; }","duration":"149.975608ms","start":"2026-04-16T00:51:23.68679Z","end":"2026-04-16T00:51:23.836765Z","steps":["trace[1293186770] 'agreement among raft nodes before linearized reading' (duration: 149.756232ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:24.142324Z","caller":"traceutil/trace.go:171","msg":"trace[1492545806] transaction","detail":"{read_only:false; response_revision:2335; number_of_response:1; }","duration":"254.425781ms","start":"2026-04-16T00:51:23.887872Z","end":"2026-04-16T00:51:24.142298Z","steps":["trace[1492545806] 'process raft request' (duration: 254.235316ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:24.328198Z","caller":"traceutil/trace.go:171","msg":"trace[1915832348] transaction","detail":"{read_only:false; response_revision:2336; number_of_response:1; }","duration":"212.651576ms","start":"2026-04-16T00:51:24.115517Z","end":"2026-04-16T00:51:24.328168Z","steps":["trace[1915832348] 'process raft request' (duration: 156.60839ms)","trace[1915832348] 'compare' (duration: 55.777659ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:24.328327Z","caller":"traceutil/trace.go:171","msg":"trace[1701364909] linearizableReadLoop","detail":"{readStateIndex:2431; appliedIndex:2430; }","duration":"179.889046ms","start":"2026-04-16T00:51:24.148412Z","end":"2026-04-16T00:51:24.328301Z","steps":["trace[1701364909] 'read index received' (duration: 123.682005ms)","trace[1701364909] 'applied index is now lower than readState.Index' (duration: 56.205191ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:24.328493Z","caller":"traceutil/trace.go:171","msg":"trace[1299452434] transaction","detail":"{read_only:false; response_revision:2338; number_of_response:1; }","duration":"177.197581ms","start":"2026-04-16T00:51:24.151279Z","end":"2026-04-16T00:51:24.328476Z","steps":["trace[1299452434] 'process raft request' (duration: 177.059828ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:24.32848Z","caller":"traceutil/trace.go:171","msg":"trace[1425199055] transaction","detail":"{read_only:false; response_revision:2337; number_of_response:1; }","duration":"179.514716ms","start":"2026-04-16T00:51:24.148934Z","end":"2026-04-16T00:51:24.328449Z","steps":["trace[1425199055] 'process raft request' (duration: 179.161186ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:24.328532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.104722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-m7sld\" ","response":"range_response_count:1 size:5641"} {"level":"info","ts":"2026-04-16T00:51:24.328586Z","caller":"traceutil/trace.go:171","msg":"trace[1608968078] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-m7sld; range_end:; response_count:1; response_revision:2337; }","duration":"180.215165ms","start":"2026-04-16T00:51:24.148357Z","end":"2026-04-16T00:51:24.328572Z","steps":["trace[1608968078] 'agreement among raft nodes before linearized reading' (duration: 180.03498ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:26.225117Z","caller":"traceutil/trace.go:171","msg":"trace[1474168184] linearizableReadLoop","detail":"{readStateIndex:2459; appliedIndex:2458; }","duration":"184.223743ms","start":"2026-04-16T00:51:26.040876Z","end":"2026-04-16T00:51:26.225099Z","steps":["trace[1474168184] 'read index received' (duration: 184.074689ms)","trace[1474168184] 'applied index is now lower than readState.Index' (duration: 148.454µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:26.225171Z","caller":"traceutil/trace.go:171","msg":"trace[2091325583] transaction","detail":"{read_only:false; response_revision:2364; number_of_response:1; }","duration":"187.894415ms","start":"2026-04-16T00:51:26.037258Z","end":"2026-04-16T00:51:26.225152Z","steps":["trace[2091325583] 'process raft request' (duration: 187.733411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:26.225229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.335486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:26.225252Z","caller":"traceutil/trace.go:171","msg":"trace[514769564] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:2364; }","duration":"184.412048ms","start":"2026-04-16T00:51:26.040833Z","end":"2026-04-16T00:51:26.225245Z","steps":["trace[514769564] 'agreement among raft nodes before linearized reading' (duration: 184.348166ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:26.225439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.149962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11986"} {"level":"info","ts":"2026-04-16T00:51:26.225468Z","caller":"traceutil/trace.go:171","msg":"trace[1407633390] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2364; }","duration":"104.202474ms","start":"2026-04-16T00:51:26.121256Z","end":"2026-04-16T00:51:26.225459Z","steps":["trace[1407633390] 'agreement among raft nodes before linearized reading' (duration: 104.05476ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:30.071215Z","caller":"traceutil/trace.go:171","msg":"trace[1184723870] linearizableReadLoop","detail":"{readStateIndex:2492; appliedIndex:2491; }","duration":"198.53633ms","start":"2026-04-16T00:51:29.872654Z","end":"2026-04-16T00:51:30.071191Z","steps":["trace[1184723870] 'read index received' (duration: 198.347764ms)","trace[1184723870] 'applied index is now lower than readState.Index' (duration: 187.646µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:30.071504Z","caller":"traceutil/trace.go:171","msg":"trace[1453214285] transaction","detail":"{read_only:false; response_revision:2395; number_of_response:1; }","duration":"210.36323ms","start":"2026-04-16T00:51:29.861128Z","end":"2026-04-16T00:51:30.071491Z","steps":["trace[1453214285] 'process raft request' (duration: 209.898037ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:30.072149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.481906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:30.072191Z","caller":"traceutil/trace.go:171","msg":"trace[1622064377] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2395; }","duration":"199.580688ms","start":"2026-04-16T00:51:29.872598Z","end":"2026-04-16T00:51:30.072178Z","steps":["trace[1622064377] 'agreement among raft nodes before linearized reading' (duration: 199.359132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:30.07712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.647161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1633"} {"level":"info","ts":"2026-04-16T00:51:30.077201Z","caller":"traceutil/trace.go:171","msg":"trace[505842157] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:2395; }","duration":"189.755303ms","start":"2026-04-16T00:51:29.887423Z","end":"2026-04-16T00:51:30.077178Z","steps":["trace[505842157] 'agreement among raft nodes before linearized reading' (duration: 185.332229ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:30.653421Z","caller":"traceutil/trace.go:171","msg":"trace[677317751] transaction","detail":"{read_only:false; response_revision:2396; number_of_response:1; }","duration":"301.767047ms","start":"2026-04-16T00:51:30.35163Z","end":"2026-04-16T00:51:30.653397Z","steps":["trace[677317751] 'process raft request' (duration: 301.626073ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:30.653562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:30.3516Z","time spent":"301.888791ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:31.81567Z","caller":"traceutil/trace.go:171","msg":"trace[1463537793] transaction","detail":"{read_only:false; response_revision:2404; number_of_response:1; }","duration":"310.752911ms","start":"2026-04-16T00:51:31.504896Z","end":"2026-04-16T00:51:31.815649Z","steps":["trace[1463537793] 'process raft request' (duration: 310.609927ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:31.815802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:31.504873Z","time spent":"310.857625ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":544,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:51.352919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.461772ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:51.353095Z","caller":"traceutil/trace.go:171","msg":"trace[1738034915] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2520; }","duration":"280.703758ms","start":"2026-04-16T00:51:51.072369Z","end":"2026-04-16T00:51:51.353073Z","steps":["trace[1738034915] 'range keys from in-memory index tree' (duration: 280.350369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.353628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.664646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T00:51:51.3537Z","caller":"traceutil/trace.go:171","msg":"trace[1285970379] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2520; }","duration":"400.757649ms","start":"2026-04-16T00:51:50.952924Z","end":"2026-04-16T00:51:51.353681Z","steps":["trace[1285970379] 'range keys from in-memory index tree' (duration: 400.525062ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.353737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:50.952913Z","time spent":"400.81641ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T00:51:51.353792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.083974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-16T00:51:51.353261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.902896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:51.35398Z","caller":"traceutil/trace.go:171","msg":"trace[568297355] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2520; }","duration":"137.696268ms","start":"2026-04-16T00:51:51.216265Z","end":"2026-04-16T00:51:51.353962Z","steps":["trace[568297355] 'range keys from in-memory index tree' (duration: 136.753572ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:51.353955Z","caller":"traceutil/trace.go:171","msg":"trace[1156425499] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2520; }","duration":"373.215268ms","start":"2026-04-16T00:51:50.980684Z","end":"2026-04-16T00:51:51.353899Z","steps":["trace[1156425499] 'range keys from in-memory index tree' (duration: 372.674702ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.353566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.514676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a6b0125b163807\" ","response":"range_response_count:1 size:846"} {"level":"warn","ts":"2026-04-16T00:51:51.354247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:50.980676Z","time spent":"373.556498ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-16T00:51:51.354388Z","caller":"traceutil/trace.go:171","msg":"trace[964762327] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a6b0125b163807; range_end:; response_count:1; response_revision:2520; }","duration":"374.256848ms","start":"2026-04-16T00:51:50.979987Z","end":"2026-04-16T00:51:51.354244Z","steps":["trace[964762327] 'range keys from in-memory index tree' (duration: 373.322391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.354505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:50.979977Z","time spent":"374.455863ms","remote":"127.0.0.1:36400","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":870,"request content":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a6b0125b163807\" "} {"level":"warn","ts":"2026-04-16T00:51:51.355185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.518267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-16T00:51:51.355283Z","caller":"traceutil/trace.go:171","msg":"trace[670780582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2520; }","duration":"341.63383ms","start":"2026-04-16T00:51:51.013632Z","end":"2026-04-16T00:51:51.355266Z","steps":["trace[670780582] 'range keys from in-memory index tree' (duration: 339.678644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.355353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:51.01361Z","time spent":"341.729542ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T00:51:51.834308Z","caller":"traceutil/trace.go:171","msg":"trace[1262199962] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"477.00144ms","start":"2026-04-16T00:51:51.357275Z","end":"2026-04-16T00:51:51.834277Z","steps":["trace[1262199962] 'process raft request' (duration: 476.826675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.834512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:51.357253Z","time spent":"477.136565ms","remote":"127.0.0.1:36400","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":831,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:51.839411Z","caller":"traceutil/trace.go:171","msg":"trace[879459488] transaction","detail":"{read_only:false; response_revision:2522; number_of_response:1; }","duration":"480.052108ms","start":"2026-04-16T00:51:51.359334Z","end":"2026-04-16T00:51:51.839386Z","steps":["trace[879459488] 'process raft request' (duration: 479.884603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.839579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:51.359315Z","time spent":"480.168401ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:51.839785Z","caller":"traceutil/trace.go:171","msg":"trace[2031074379] linearizableReadLoop","detail":"{readStateIndex:2625; appliedIndex:2621; }","duration":"475.814426ms","start":"2026-04-16T00:51:51.363949Z","end":"2026-04-16T00:51:51.839763Z","steps":["trace[2031074379] 'read index received' (duration: 470.100682ms)","trace[2031074379] 'applied index is now lower than readState.Index' (duration: 5.712764ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:51.839875Z","caller":"traceutil/trace.go:171","msg":"trace[687812094] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"480.208522ms","start":"2026-04-16T00:51:51.359628Z","end":"2026-04-16T00:51:51.839837Z","steps":["trace[687812094] 'process raft request' (duration: 479.975255ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:51.84004Z","caller":"traceutil/trace.go:171","msg":"trace[2078643281] transaction","detail":"{read_only:false; response_revision:2523; number_of_response:1; }","duration":"480.640695ms","start":"2026-04-16T00:51:51.359386Z","end":"2026-04-16T00:51:51.840027Z","steps":["trace[2078643281] 'process raft request' (duration: 479.957955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.840038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.803403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:51:51.840005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.051404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T00:51:51.840138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:51.359369Z","time spent":"480.734608ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:51.840154Z","caller":"traceutil/trace.go:171","msg":"trace[1900886364] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2524; }","duration":"286.980379ms","start":"2026-04-16T00:51:51.553126Z","end":"2026-04-16T00:51:51.840106Z","steps":["trace[1900886364] 'agreement among raft nodes before linearized reading' (duration: 286.794103ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:51.840212Z","caller":"traceutil/trace.go:171","msg":"trace[2064418071] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2524; }","duration":"476.396633ms","start":"2026-04-16T00:51:51.363799Z","end":"2026-04-16T00:51:51.840196Z","steps":["trace[2064418071] 'agreement among raft nodes before linearized reading' (duration: 476.078394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:51.840262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:51.363791Z","time spent":"476.459015ms","remote":"127.0.0.1:36812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-16T00:51:51.84026Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:51.359622Z","time spent":"480.361247ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:53.027664Z","caller":"traceutil/trace.go:171","msg":"trace[2087010942] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"265.278344ms","start":"2026-04-16T00:51:52.762362Z","end":"2026-04-16T00:51:53.02764Z","steps":["trace[2087010942] 'process raft request' (duration: 265.13038ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:53.038411Z","caller":"traceutil/trace.go:171","msg":"trace[338077753] transaction","detail":"{read_only:false; response_revision:2528; number_of_response:1; }","duration":"180.656039ms","start":"2026-04-16T00:51:52.857741Z","end":"2026-04-16T00:51:53.038397Z","steps":["trace[338077753] 'process raft request' (duration: 180.527545ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:53.03846Z","caller":"traceutil/trace.go:171","msg":"trace[2003564935] linearizableReadLoop","detail":"{readStateIndex:2632; appliedIndex:2627; }","duration":"133.454911ms","start":"2026-04-16T00:51:52.904972Z","end":"2026-04-16T00:51:53.038427Z","steps":["trace[2003564935] 'read index received' (duration: 122.520826ms)","trace[2003564935] 'applied index is now lower than readState.Index' (duration: 10.933225ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:53.038479Z","caller":"traceutil/trace.go:171","msg":"trace[209320641] transaction","detail":"{read_only:false; response_revision:2529; number_of_response:1; }","duration":"167.633334ms","start":"2026-04-16T00:51:52.870819Z","end":"2026-04-16T00:51:53.038452Z","steps":["trace[209320641] 'process raft request' (duration: 167.533812ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:53.03845Z","caller":"traceutil/trace.go:171","msg":"trace[1937414285] transaction","detail":"{read_only:false; response_revision:2527; number_of_response:1; }","duration":"191.309555ms","start":"2026-04-16T00:51:52.847093Z","end":"2026-04-16T00:51:53.038403Z","steps":["trace[1937414285] 'process raft request' (duration: 191.032327ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:53.038695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.706448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T00:51:53.038739Z","caller":"traceutil/trace.go:171","msg":"trace[276246627] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2530; }","duration":"133.764129ms","start":"2026-04-16T00:51:52.904964Z","end":"2026-04-16T00:51:53.038728Z","steps":["trace[276246627] 'agreement among raft nodes before linearized reading' (duration: 133.587564ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:53.039108Z","caller":"traceutil/trace.go:171","msg":"trace[2134460089] transaction","detail":"{read_only:false; response_revision:2530; number_of_response:1; }","duration":"167.327405ms","start":"2026-04-16T00:51:52.871189Z","end":"2026-04-16T00:51:53.038516Z","steps":["trace[2134460089] 'process raft request' (duration: 167.203282ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:54.529938Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976531751534285441,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T00:51:54.794891Z","caller":"traceutil/trace.go:171","msg":"trace[1049180072] transaction","detail":"{read_only:false; response_revision:2532; number_of_response:1; }","duration":"947.363876ms","start":"2026-04-16T00:51:53.847499Z","end":"2026-04-16T00:51:54.794863Z","steps":["trace[1049180072] 'process raft request' (duration: 947.209782ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:54.795043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:53.847485Z","time spent":"947.480619ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:55.11176Z","caller":"traceutil/trace.go:171","msg":"trace[1957385456] transaction","detail":"{read_only:false; response_revision:2534; number_of_response:1; }","duration":"1.262944866s","start":"2026-04-16T00:51:53.848794Z","end":"2026-04-16T00:51:55.111739Z","steps":["trace[1957385456] 'process raft request' (duration: 1.262866764s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.111887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:53.848787Z","time spent":"1.263033039s","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:55.111945Z","caller":"traceutil/trace.go:171","msg":"trace[1030545147] transaction","detail":"{read_only:false; response_revision:2533; number_of_response:1; }","duration":"1.264247635s","start":"2026-04-16T00:51:53.84767Z","end":"2026-04-16T00:51:55.111917Z","steps":["trace[1030545147] 'process raft request' (duration: 1.222450349s)","trace[1030545147] 'compare' (duration: 41.24899ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:51:55.112113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:53.847663Z","time spent":"1.264343317s","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:55.1123Z","caller":"traceutil/trace.go:171","msg":"trace[320100062] linearizableReadLoop","detail":"{readStateIndex:2636; appliedIndex:2634; }","duration":"1.082477268s","start":"2026-04-16T00:51:54.029812Z","end":"2026-04-16T00:51:55.112289Z","steps":["trace[320100062] 'read index received' (duration: 765.399914ms)","trace[320100062] 'applied index is now lower than readState.Index' (duration: 317.076414ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:51:55.112406Z","caller":"traceutil/trace.go:171","msg":"trace[1298379920] transaction","detail":"{read_only:false; response_revision:2535; number_of_response:1; }","duration":"452.657623ms","start":"2026-04-16T00:51:54.659739Z","end":"2026-04-16T00:51:55.112397Z","steps":["trace[1298379920] 'process raft request' (duration: 451.970314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.112464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:54.659707Z","time spent":"452.720794ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:55.112505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.082695104s","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-04-16T00:51:55.112546Z","caller":"traceutil/trace.go:171","msg":"trace[1401968135] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:2535; }","duration":"1.082736976s","start":"2026-04-16T00:51:54.029795Z","end":"2026-04-16T00:51:55.112532Z","steps":["trace[1401968135] 'agreement among raft nodes before linearized reading' (duration: 1.082668964s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.112594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:54.029736Z","time spent":"1.082849609s","remote":"127.0.0.1:36854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":3,"response size":31,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-04-16T00:51:55.612969Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13976531751534285450,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T00:51:55.799594Z","caller":"traceutil/trace.go:171","msg":"trace[2065292084] transaction","detail":"{read_only:false; response_revision:2536; number_of_response:1; }","duration":"755.909523ms","start":"2026-04-16T00:51:55.043657Z","end":"2026-04-16T00:51:55.799566Z","steps":["trace[2065292084] 'process raft request' (duration: 709.7177ms)","trace[2065292084] 'compare' (duration: 45.934976ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:51:55.799443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.744716ms","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-04-16T00:51:55.799719Z","caller":"traceutil/trace.go:171","msg":"trace[703381626] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:2535; }","duration":"417.033065ms","start":"2026-04-16T00:51:55.382668Z","end":"2026-04-16T00:51:55.799701Z","steps":["trace[703381626] 'range keys from in-memory index tree' (duration: 416.714025ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.800049Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:55.043639Z","time spent":"756.060338ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:55.800291Z","caller":"traceutil/trace.go:171","msg":"trace[1847620888] transaction","detail":"{read_only:false; response_revision:2537; number_of_response:1; }","duration":"756.450288ms","start":"2026-04-16T00:51:55.04382Z","end":"2026-04-16T00:51:55.800271Z","steps":["trace[1847620888] 'process raft request' (duration: 755.699187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.80042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:55.043816Z","time spent":"756.52748ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:51:55.801084Z","caller":"traceutil/trace.go:171","msg":"trace[678507831] linearizableReadLoop","detail":"{readStateIndex:2641; appliedIndex:2637; }","duration":"688.742725ms","start":"2026-04-16T00:51:55.112327Z","end":"2026-04-16T00:51:55.80107Z","steps":["trace[678507831] 'read index received' (duration: 641.104291ms)","trace[678507831] 'applied index is now lower than readState.Index' (duration: 47.637334ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:51:55.801168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.728738059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:55.801194Z","caller":"traceutil/trace.go:171","msg":"trace[1627500365] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2539; }","duration":"1.728810431s","start":"2026-04-16T00:51:54.072375Z","end":"2026-04-16T00:51:55.801186Z","steps":["trace[1627500365] 'agreement among raft nodes before linearized reading' (duration: 1.728759979s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.801306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.529395153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:51:55.801373Z","caller":"traceutil/trace.go:171","msg":"trace[1399963965] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:2539; }","duration":"1.529484936s","start":"2026-04-16T00:51:54.271869Z","end":"2026-04-16T00:51:55.801354Z","steps":["trace[1399963965] 'agreement among raft nodes before linearized reading' (duration: 1.529379832s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.801466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:54.271862Z","time spent":"1.529594348s","remote":"127.0.0.1:36416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-04-16T00:51:55.801238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.56445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T00:51:55.801513Z","caller":"traceutil/trace.go:171","msg":"trace[1953748375] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2539; }","duration":"714.869359ms","start":"2026-04-16T00:51:55.086629Z","end":"2026-04-16T00:51:55.801498Z","steps":["trace[1953748375] 'agreement among raft nodes before linearized reading' (duration: 714.498108ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.801679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:55.086613Z","time spent":"715.052603ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T00:51:55.801221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:54.072349Z","time spent":"1.728865542s","remote":"127.0.0.1:36330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T00:51:55.801954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.541241375s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-04-16T00:51:55.801986Z","caller":"traceutil/trace.go:171","msg":"trace[1078415420] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2539; }","duration":"1.541314467s","start":"2026-04-16T00:51:54.260665Z","end":"2026-04-16T00:51:55.801979Z","steps":["trace[1078415420] 'agreement among raft nodes before linearized reading' (duration: 1.541240484s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.802007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:54.260641Z","time spent":"1.541362138s","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T00:51:55.802003Z","caller":"traceutil/trace.go:171","msg":"trace[753332606] transaction","detail":"{read_only:false; response_revision:2538; number_of_response:1; }","duration":"757.969422ms","start":"2026-04-16T00:51:55.043958Z","end":"2026-04-16T00:51:55.801927Z","steps":["trace[753332606] 'process raft request' (duration: 756.914072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.801743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425612201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-16T00:51:55.802179Z","caller":"traceutil/trace.go:171","msg":"trace[181491695] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2539; }","duration":"1.426070375s","start":"2026-04-16T00:51:54.37609Z","end":"2026-04-16T00:51:55.80216Z","steps":["trace[181491695] 'agreement among raft nodes before linearized reading' (duration: 1.42555971s)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:51:55.802224Z","caller":"traceutil/trace.go:171","msg":"trace[1489314127] transaction","detail":"{read_only:false; response_revision:2539; number_of_response:1; }","duration":"757.976392ms","start":"2026-04-16T00:51:55.044239Z","end":"2026-04-16T00:51:55.802216Z","steps":["trace[1489314127] 'process raft request' (duration: 756.778848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:51:55.802228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:54.376048Z","time spent":"1.426167417s","remote":"127.0.0.1:51890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-16T00:51:55.80229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:55.044228Z","time spent":"758.020924ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:51:55.802287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:51:55.043931Z","time spent":"758.204319ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:53:14.239155Z","caller":"traceutil/trace.go:171","msg":"trace[1425163442] transaction","detail":"{read_only:false; response_revision:3013; number_of_response:1; }","duration":"134.422354ms","start":"2026-04-16T00:53:14.104703Z","end":"2026-04-16T00:53:14.239126Z","steps":["trace[1425163442] 'process raft request' (duration: 98.738661ms)","trace[1425163442] 'compare' (duration: 35.481077ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:53:14.239447Z","caller":"traceutil/trace.go:171","msg":"trace[292762481] linearizableReadLoop","detail":"{readStateIndex:3134; appliedIndex:3131; }","duration":"114.488624ms","start":"2026-04-16T00:53:14.124938Z","end":"2026-04-16T00:53:14.239426Z","steps":["trace[292762481] 'read index received' (duration: 78.517092ms)","trace[292762481] 'applied index is now lower than readState.Index' (duration: 35.970692ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:53:14.239481Z","caller":"traceutil/trace.go:171","msg":"trace[912256571] transaction","detail":"{read_only:false; response_revision:3014; number_of_response:1; }","duration":"131.265369ms","start":"2026-04-16T00:53:14.108188Z","end":"2026-04-16T00:53:14.239453Z","steps":["trace[912256571] 'process raft request' (duration: 130.892868ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:53:14.23953Z","caller":"traceutil/trace.go:171","msg":"trace[1411831421] transaction","detail":"{read_only:false; response_revision:3015; number_of_response:1; }","duration":"131.208197ms","start":"2026-04-16T00:53:14.108302Z","end":"2026-04-16T00:53:14.239511Z","steps":["trace[1411831421] 'process raft request' (duration: 131.040042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:53:14.239668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.719181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T00:53:14.239711Z","caller":"traceutil/trace.go:171","msg":"trace[1207560372] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3015; }","duration":"114.814614ms","start":"2026-04-16T00:53:14.124885Z","end":"2026-04-16T00:53:14.2397Z","steps":["trace[1207560372] 'agreement among raft nodes before linearized reading' (duration: 114.67065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:53:14.239753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.110382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T00:53:14.239795Z","caller":"traceutil/trace.go:171","msg":"trace[46652017] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3015; }","duration":"102.196514ms","start":"2026-04-16T00:53:14.137588Z","end":"2026-04-16T00:53:14.239785Z","steps":["trace[46652017] 'agreement among raft nodes before linearized reading' (duration: 102.055ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:53:46.415123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.122179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:53:46.415281Z","caller":"traceutil/trace.go:171","msg":"trace[31210570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3185; }","duration":"343.324023ms","start":"2026-04-16T00:53:46.071937Z","end":"2026-04-16T00:53:46.415261Z","steps":["trace[31210570] 'range keys from in-memory index tree' (duration: 342.983267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:53:46.415156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"750.277859ms","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":"warn","ts":"2026-04-16T00:53:46.415651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:53:46.071911Z","time spent":"343.725449ms","remote":"127.0.0.1:36316","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-16T00:53:46.415658Z","caller":"traceutil/trace.go:171","msg":"trace[2032171056] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:3185; }","duration":"750.814298ms","start":"2026-04-16T00:53:45.66479Z","end":"2026-04-16T00:53:46.415604Z","steps":["trace[2032171056] 'range keys from in-memory index tree' (duration: 750.077526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:53:46.415862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:53:45.664747Z","time spent":"751.081213ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T00:53:46.415503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.471344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-16T00:53:46.416004Z","caller":"traceutil/trace.go:171","msg":"trace[469079830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3185; }","duration":"754.006773ms","start":"2026-04-16T00:53:45.661967Z","end":"2026-04-16T00:53:46.415974Z","steps":["trace[469079830] 'range keys from in-memory index tree' (duration: 752.561878ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:53:46.416488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:53:45.661947Z","time spent":"754.489291ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-16T00:53:46.512668Z","caller":"traceutil/trace.go:171","msg":"trace[1474338963] transaction","detail":"{read_only:false; response_revision:3186; number_of_response:1; }","duration":"285.626772ms","start":"2026-04-16T00:53:46.227017Z","end":"2026-04-16T00:53:46.512644Z","steps":["trace[1474338963] 'process raft request' (duration: 285.408448ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:53:46.56793Z","caller":"traceutil/trace.go:171","msg":"trace[942565502] transaction","detail":"{read_only:false; response_revision:3187; number_of_response:1; }","duration":"148.260599ms","start":"2026-04-16T00:53:46.419637Z","end":"2026-04-16T00:53:46.567897Z","steps":["trace[942565502] 'process raft request' (duration: 125.548029ms)","trace[942565502] 'compare' (duration: 22.516167ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:53:46.568361Z","caller":"traceutil/trace.go:171","msg":"trace[96535346] transaction","detail":"{read_only:false; response_revision:3188; number_of_response:1; }","duration":"147.949894ms","start":"2026-04-16T00:53:46.420385Z","end":"2026-04-16T00:53:46.568335Z","steps":["trace[96535346] 'process raft request' (duration: 147.459886ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:53:46.568518Z","caller":"traceutil/trace.go:171","msg":"trace[1499941636] transaction","detail":"{read_only:false; response_revision:3189; number_of_response:1; }","duration":"148.080556ms","start":"2026-04-16T00:53:46.420425Z","end":"2026-04-16T00:53:46.568505Z","steps":["trace[1499941636] 'process raft request' (duration: 147.797021ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:53:46.568712Z","caller":"traceutil/trace.go:171","msg":"trace[1673196009] transaction","detail":"{read_only:false; response_revision:3190; number_of_response:1; }","duration":"125.765892ms","start":"2026-04-16T00:53:46.442936Z","end":"2026-04-16T00:53:46.568702Z","steps":["trace[1673196009] 'process raft request' (duration: 125.518558ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:53:46.568909Z","caller":"traceutil/trace.go:171","msg":"trace[754217274] transaction","detail":"{read_only:false; response_revision:3191; number_of_response:1; }","duration":"125.884045ms","start":"2026-04-16T00:53:46.443015Z","end":"2026-04-16T00:53:46.568899Z","steps":["trace[754217274] 'process raft request' (duration: 125.655611ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:53:50.681634Z","caller":"traceutil/trace.go:171","msg":"trace[1325615719] transaction","detail":"{read_only:false; response_revision:3210; number_of_response:1; }","duration":"100.81507ms","start":"2026-04-16T00:53:50.580788Z","end":"2026-04-16T00:53:50.681603Z","steps":["trace[1325615719] 'process raft request' (duration: 54.707681ms)","trace[1325615719] 'compare' (duration: 45.908555ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:55:55.185679Z","caller":"traceutil/trace.go:171","msg":"trace[159321420] transaction","detail":"{read_only:false; response_revision:4059; number_of_response:1; }","duration":"123.683735ms","start":"2026-04-16T00:55:55.061975Z","end":"2026-04-16T00:55:55.185659Z","steps":["trace[159321420] 'process raft request' (duration: 41.511139ms)","trace[159321420] 'compare' (duration: 81.972921ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:55:55.185881Z","caller":"traceutil/trace.go:171","msg":"trace[1349905949] linearizableReadLoop","detail":"{readStateIndex:4216; appliedIndex:4215; }","duration":"119.370699ms","start":"2026-04-16T00:55:55.066494Z","end":"2026-04-16T00:55:55.185864Z","steps":["trace[1349905949] 'read index received' (duration: 36.940427ms)","trace[1349905949] 'applied index is now lower than readState.Index' (duration: 82.428582ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T00:55:55.186156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.637056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret\" ","response":"range_response_count:1 size:1219"} {"level":"info","ts":"2026-04-16T00:55:55.186202Z","caller":"traceutil/trace.go:171","msg":"trace[1662296248] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/monitoring/kube-prometheus-stack-grafana-client-secret; range_end:; response_count:1; response_revision:4060; }","duration":"119.720328ms","start":"2026-04-16T00:55:55.066467Z","end":"2026-04-16T00:55:55.186187Z","steps":["trace[1662296248] 'agreement among raft nodes before linearized reading' (duration: 119.508663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:55:55.205205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.849825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T00:55:55.205434Z","caller":"traceutil/trace.go:171","msg":"trace[1706423713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4062; }","duration":"134.567602ms","start":"2026-04-16T00:55:55.070832Z","end":"2026-04-16T00:55:55.205399Z","steps":["trace[1706423713] 'agreement among raft nodes before linearized reading' (duration: 133.849524ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:55:55.38284Z","caller":"traceutil/trace.go:171","msg":"trace[1327068301] transaction","detail":"{read_only:false; response_revision:4069; number_of_response:1; }","duration":"102.869025ms","start":"2026-04-16T00:55:55.279944Z","end":"2026-04-16T00:55:55.382813Z","steps":["trace[1327068301] 'process raft request' (duration: 21.845936ms)","trace[1327068301] 'compare' (duration: 80.68722ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:56:27.868265Z","caller":"traceutil/trace.go:171","msg":"trace[701279379] transaction","detail":"{read_only:false; response_revision:4360; number_of_response:1; }","duration":"176.566107ms","start":"2026-04-16T00:56:27.691674Z","end":"2026-04-16T00:56:27.86824Z","steps":["trace[701279379] 'process raft request' (duration: 176.352012ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:56:37.433384Z","caller":"traceutil/trace.go:171","msg":"trace[1594624951] transaction","detail":"{read_only:false; response_revision:4419; number_of_response:1; }","duration":"101.176332ms","start":"2026-04-16T00:56:37.332188Z","end":"2026-04-16T00:56:37.433365Z","steps":["trace[1594624951] 'process raft request' (duration: 100.997867ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:57:36.94905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.677859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-ndbc9.18a6b065a9026d14\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-04-16T00:57:36.949162Z","caller":"traceutil/trace.go:171","msg":"trace[1160249611] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-ndbc9.18a6b065a9026d14; range_end:; response_count:1; response_revision:5481; }","duration":"202.840373ms","start":"2026-04-16T00:57:36.746296Z","end":"2026-04-16T00:57:36.949137Z","steps":["trace[1160249611] 'range keys from in-memory index tree' (duration: 202.530305ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:57:38.501227Z","caller":"traceutil/trace.go:171","msg":"trace[268068760] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"113.008685ms","start":"2026-04-16T00:57:38.38819Z","end":"2026-04-16T00:57:38.501199Z","steps":["trace[268068760] 'process raft request' (duration: 103.610673ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:57:40.671442Z","caller":"traceutil/trace.go:171","msg":"trace[1501197855] transaction","detail":"{read_only:false; response_revision:5529; number_of_response:1; }","duration":"102.574799ms","start":"2026-04-16T00:57:40.568844Z","end":"2026-04-16T00:57:40.671418Z","steps":["trace[1501197855] 'process raft request' (duration: 102.427755ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:57:41.993833Z","caller":"traceutil/trace.go:171","msg":"trace[2058255871] transaction","detail":"{read_only:false; response_revision:5540; number_of_response:1; }","duration":"345.96337ms","start":"2026-04-16T00:57:41.647829Z","end":"2026-04-16T00:57:41.993792Z","steps":["trace[2058255871] 'process raft request' (duration: 345.793145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:57:41.994039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:57:41.647809Z","time spent":"346.093984ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:57:42.016997Z","caller":"traceutil/trace.go:171","msg":"trace[1341517318] transaction","detail":"{read_only:false; response_revision:5541; number_of_response:1; }","duration":"367.913271ms","start":"2026-04-16T00:57:41.64907Z","end":"2026-04-16T00:57:42.016983Z","steps":["trace[1341517318] 'process raft request' (duration: 367.698115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:57:42.017127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:57:41.649053Z","time spent":"367.992933ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T00:57:42.017306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.601916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-16T00:57:42.01691Z","caller":"traceutil/trace.go:171","msg":"trace[369353843] linearizableReadLoop","detail":"{readStateIndex:5747; appliedIndex:5745; }","duration":"301.196255ms","start":"2026-04-16T00:57:41.715691Z","end":"2026-04-16T00:57:42.016887Z","steps":["trace[369353843] 'read index received' (duration: 278.008271ms)","trace[369353843] 'applied index is now lower than readState.Index' (duration: 23.186954ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:57:42.017518Z","caller":"traceutil/trace.go:171","msg":"trace[1682673032] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5541; }","duration":"301.789611ms","start":"2026-04-16T00:57:41.715649Z","end":"2026-04-16T00:57:42.017438Z","steps":["trace[1682673032] 'agreement among raft nodes before linearized reading' (duration: 301.475663ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:57:42.017609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.00388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-16T00:57:42.017649Z","caller":"traceutil/trace.go:171","msg":"trace[2136573492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5541; }","duration":"256.044091ms","start":"2026-04-16T00:57:41.761594Z","end":"2026-04-16T00:57:42.017638Z","steps":["trace[2136573492] 'agreement among raft nodes before linearized reading' (duration: 255.914507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:57:42.017608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:57:41.715631Z","time spent":"301.963676ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-16T00:57:49.64503Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2840} {"level":"info","ts":"2026-04-16T00:57:49.755064Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2840,"took":"109.001415ms","hash":1389168828,"current-db-size-bytes":54329344,"current-db-size":"54 MB","current-db-size-in-use-bytes":30535680,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-16T00:57:49.75512Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1389168828,"revision":2840,"compact-revision":-1} {"level":"warn","ts":"2026-04-16T00:58:12.772369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.525396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-04-16T00:58:12.772443Z","caller":"traceutil/trace.go:171","msg":"trace[1047050075] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5782; }","duration":"148.607788ms","start":"2026-04-16T00:58:12.623818Z","end":"2026-04-16T00:58:12.772426Z","steps":["trace[1047050075] 'range keys from in-memory index tree' (duration: 148.381312ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:58:18.287973Z","caller":"traceutil/trace.go:171","msg":"trace[1726762908] transaction","detail":"{read_only:false; response_revision:5809; number_of_response:1; }","duration":"180.197782ms","start":"2026-04-16T00:58:18.107753Z","end":"2026-04-16T00:58:18.28795Z","steps":["trace[1726762908] 'process raft request' (duration: 180.018998ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T00:58:18.861119Z","caller":"traceutil/trace.go:171","msg":"trace[1726802222] transaction","detail":"{read_only:false; response_revision:5810; number_of_response:1; }","duration":"735.47185ms","start":"2026-04-16T00:58:18.125632Z","end":"2026-04-16T00:58:18.861104Z","steps":["trace[1726802222] 'process raft request' (duration: 735.334346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:58:18.861222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:58:18.125616Z","time spent":"735.552213ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:58:18.861211Z","caller":"traceutil/trace.go:171","msg":"trace[1981856960] linearizableReadLoop","detail":"{readStateIndex:6027; appliedIndex:6025; }","duration":"690.215811ms","start":"2026-04-16T00:58:18.170975Z","end":"2026-04-16T00:58:18.861191Z","steps":["trace[1981856960] 'read index received' (duration: 116.867068ms)","trace[1981856960] 'applied index is now lower than readState.Index' (duration: 573.347223ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T00:58:18.861363Z","caller":"traceutil/trace.go:171","msg":"trace[1639187907] transaction","detail":"{read_only:false; response_revision:5811; number_of_response:1; }","duration":"663.679905ms","start":"2026-04-16T00:58:18.197658Z","end":"2026-04-16T00:58:18.861338Z","steps":["trace[1639187907] 'process raft request' (duration: 663.406508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:58:18.861425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.945897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-16T00:58:18.861462Z","caller":"traceutil/trace.go:171","msg":"trace[1780401889] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5811; }","duration":"685.013409ms","start":"2026-04-16T00:58:18.176438Z","end":"2026-04-16T00:58:18.861451Z","steps":["trace[1780401889] 'agreement among raft nodes before linearized reading' (duration: 684.870586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:58:18.861493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:58:18.176426Z","time spent":"685.05921ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T00:58:18.861619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.656725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-16T00:58:18.861619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"467.789714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T00:58:18.861644Z","caller":"traceutil/trace.go:171","msg":"trace[96623540] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5811; }","duration":"682.704996ms","start":"2026-04-16T00:58:18.178931Z","end":"2026-04-16T00:58:18.861636Z","steps":["trace[96623540] 'agreement among raft nodes before linearized reading' (duration: 682.640284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:58:18.861664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:58:18.17892Z","time spent":"682.739397ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-16T00:58:18.86161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:58:18.197646Z","time spent":"663.830929ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T00:58:18.861662Z","caller":"traceutil/trace.go:171","msg":"trace[1454343220] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:5811; }","duration":"467.879026ms","start":"2026-04-16T00:58:18.393771Z","end":"2026-04-16T00:58:18.86165Z","steps":["trace[1454343220] 'agreement among raft nodes before linearized reading' (duration: 467.790794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:58:18.862018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:58:18.393748Z","time spent":"468.255957ms","remote":"127.0.0.1:36694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":31,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-04-16T00:58:18.861654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"690.677434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-16T00:58:18.862248Z","caller":"traceutil/trace.go:171","msg":"trace[1315762993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5811; }","duration":"691.295061ms","start":"2026-04-16T00:58:18.170939Z","end":"2026-04-16T00:58:18.862234Z","steps":["trace[1315762993] 'agreement among raft nodes before linearized reading' (duration: 690.360985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:58:18.862292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:58:18.170928Z","time spent":"691.353142ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-16T00:58:18.861755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"683.172189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T00:58:18.862379Z","caller":"traceutil/trace.go:171","msg":"trace[430883285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5811; }","duration":"683.818796ms","start":"2026-04-16T00:58:18.178538Z","end":"2026-04-16T00:58:18.862357Z","steps":["trace[430883285] 'agreement among raft nodes before linearized reading' (duration: 683.173079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T00:58:18.862436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T00:58:18.178516Z","time spent":"683.906129ms","remote":"127.0.0.1:36612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "}