{"level":"warn","ts":"2026-07-01T09:28:46.259726Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T09:28:46.259808Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-07-01T09:28:46.259875Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T09:28:46.259887Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-07-01T09:28:46.259905Z","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-07-01T09:28:46.260515Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-07-01T09:28:46.260586Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-07-01T09:28:46.273232Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"12.4559ms"} {"level":"info","ts":"2026-07-01T09:28:46.287866Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-07-01T09:28:46.287924Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T09:28:46.287942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-07-01T09:28:46.287956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T09:28:46.287963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-07-01T09:28:46.287998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-07-01T09:28:46.300306Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T09:28:46.302823Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T09:28:46.304193Z","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-07-01T09:28:46.307332Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T09:28:46.307911Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T09:28:46.308209Z","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-07-01T09:28:46.308257Z","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-07-01T09:28:46.308265Z","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-07-01T09:28:46.308663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-07-01T09:28:46.309914Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-07-01T09:28:46.315151Z","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-07-01T09:28:46.315305Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-07-01T09:28:46.31534Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-07-01T09:28:46.315767Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T09:28:46.315835Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T09:28:46.588657Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T09:28:46.58874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T09:28:46.58879Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-07-01T09:28:46.588866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-07-01T09:28:46.588885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-07-01T09:28:46.58894Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-07-01T09:28:46.588963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-07-01T09:28:46.602329Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T09:28:46.660873Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T09:28:46.660901Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T09:28:46.661039Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T09:28:46.661155Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T09:28:46.661456Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T09:28:46.661532Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T09:28:46.662966Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T09:28:46.663377Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T09:28:46.663517Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T09:28:46.672293Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"warn","ts":"2026-07-01T09:28:48.511747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.024204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-07-01T09:28:48.512301Z","caller":"traceutil/trace.go:171","msg":"trace[2127325803] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"167.64126ms","start":"2026-07-01T09:28:48.344632Z","end":"2026-07-01T09:28:48.512274Z","steps":["trace[2127325803] 'process raft request' (duration: 167.594469ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.512506Z","caller":"traceutil/trace.go:171","msg":"trace[1287030259] linearizableReadLoop","detail":"{readStateIndex:13; appliedIndex:7; }","duration":"265.150389ms","start":"2026-07-01T09:28:48.247321Z","end":"2026-07-01T09:28:48.512471Z","steps":["trace[1287030259] 'read index received' (duration: 92.104101ms)","trace[1287030259] 'applied index is now lower than readState.Index' (duration: 173.043878ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:28:48.512586Z","caller":"traceutil/trace.go:171","msg":"trace[1001196534] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"262.096715ms","start":"2026-07-01T09:28:48.250425Z","end":"2026-07-01T09:28:48.512522Z","steps":["trace[1001196534] 'process raft request' (duration: 261.642983ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.512603Z","caller":"traceutil/trace.go:171","msg":"trace[823962789] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"264.321386ms","start":"2026-07-01T09:28:48.24826Z","end":"2026-07-01T09:28:48.512582Z","steps":["trace[823962789] 'process raft request' (duration: 263.766611ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.512762Z","caller":"traceutil/trace.go:171","msg":"trace[995969241] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"271.117202ms","start":"2026-07-01T09:28:48.241342Z","end":"2026-07-01T09:28:48.51246Z","steps":["trace[995969241] 'process raft request' (duration: 117.512904ms)","trace[995969241] 'compare' (duration: 151.821829ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:28:48.513033Z","caller":"traceutil/trace.go:171","msg":"trace[1816210259] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"271.611405ms","start":"2026-07-01T09:28:48.241409Z","end":"2026-07-01T09:28:48.51302Z","steps":["trace[1816210259] 'process raft request' (duration: 270.516135ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.51334Z","caller":"traceutil/trace.go:171","msg":"trace[752188143] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"169.302626ms","start":"2026-07-01T09:28:48.344021Z","end":"2026-07-01T09:28:48.513323Z","steps":["trace[752188143] 'process raft request' (duration: 168.116614ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.513516Z","caller":"traceutil/trace.go:171","msg":"trace[1447092349] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"169.398788ms","start":"2026-07-01T09:28:48.344105Z","end":"2026-07-01T09:28:48.513503Z","steps":["trace[1447092349] 'process raft request' (duration: 168.082642ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.512221Z","caller":"traceutil/trace.go:171","msg":"trace[1659259198] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"266.735162ms","start":"2026-07-01T09:28:48.245451Z","end":"2026-07-01T09:28:48.512186Z","steps":["trace[1659259198] 'process raft request' (duration: 266.529846ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.515534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.751711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-07-01T09:28:48.515745Z","caller":"traceutil/trace.go:171","msg":"trace[676159155] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:15; }","duration":"266.125875ms","start":"2026-07-01T09:28:48.249588Z","end":"2026-07-01T09:28:48.515713Z","steps":["trace[676159155] 'agreement among raft nodes before linearized reading' (duration: 263.74772ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.515514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.236616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.515905Z","caller":"traceutil/trace.go:171","msg":"trace[138146166] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:15; }","duration":"314.095733ms","start":"2026-07-01T09:28:48.201792Z","end":"2026-07-01T09:28:48.515887Z","steps":["trace[138146166] 'agreement among raft nodes before linearized reading' (duration: 311.161083ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.516611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:28:48.201779Z","time spent":"314.195546ms","remote":"127.0.0.1:58564","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-01T09:28:48.518886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.300784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.518938Z","caller":"traceutil/trace.go:171","msg":"trace[1565345584] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:15; }","duration":"283.370666ms","start":"2026-07-01T09:28:48.235554Z","end":"2026-07-01T09:28:48.518924Z","steps":["trace[1565345584] 'agreement among raft nodes before linearized reading' (duration: 283.259343ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.519429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.57194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.519492Z","caller":"traceutil/trace.go:171","msg":"trace[2085376066] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:15; }","duration":"286.507571ms","start":"2026-07-01T09:28:48.23297Z","end":"2026-07-01T09:28:48.519478Z","steps":["trace[2085376066] 'agreement among raft nodes before linearized reading' (duration: 279.639334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.519729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.861272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.519755Z","caller":"traceutil/trace.go:171","msg":"trace[1153913944] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:15; }","duration":"233.400453ms","start":"2026-07-01T09:28:48.286346Z","end":"2026-07-01T09:28:48.519747Z","steps":["trace[1153913944] 'agreement among raft nodes before linearized reading' (duration: 227.858492ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.520764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.772002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.520825Z","caller":"traceutil/trace.go:171","msg":"trace[1338018692] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:0; response_revision:15; }","duration":"288.860775ms","start":"2026-07-01T09:28:48.231947Z","end":"2026-07-01T09:28:48.520807Z","steps":["trace[1338018692] 'agreement among raft nodes before linearized reading' (duration: 281.763792ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.798436Z","caller":"traceutil/trace.go:171","msg":"trace[610657801] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"278.862313ms","start":"2026-07-01T09:28:48.519533Z","end":"2026-07-01T09:28:48.798395Z","steps":["trace[610657801] 'process raft request' (duration: 233.035683ms)","trace[610657801] 'compare' (duration: 45.638494ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:28:48.799087Z","caller":"traceutil/trace.go:171","msg":"trace[1262099405] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"277.031502ms","start":"2026-07-01T09:28:48.522043Z","end":"2026-07-01T09:28:48.799074Z","steps":["trace[1262099405] 'process raft request' (duration: 276.456096ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.799167Z","caller":"traceutil/trace.go:171","msg":"trace[1546489738] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"275.816679ms","start":"2026-07-01T09:28:48.523329Z","end":"2026-07-01T09:28:48.799145Z","steps":["trace[1546489738] 'process raft request' (duration: 275.587023ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.799284Z","caller":"traceutil/trace.go:171","msg":"trace[529140147] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"275.522581ms","start":"2026-07-01T09:28:48.523737Z","end":"2026-07-01T09:28:48.799259Z","steps":["trace[529140147] 'process raft request' (duration: 275.285085ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.799366Z","caller":"traceutil/trace.go:171","msg":"trace[256701216] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:18; }","duration":"275.533391ms","start":"2026-07-01T09:28:48.523809Z","end":"2026-07-01T09:28:48.799342Z","steps":["trace[256701216] 'read index received' (duration: 228.849399ms)","trace[256701216] 'applied index is now lower than readState.Index' (duration: 46.682122ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:28:48.799534Z","caller":"traceutil/trace.go:171","msg":"trace[95728748] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"273.829055ms","start":"2026-07-01T09:28:48.52569Z","end":"2026-07-01T09:28:48.799519Z","steps":["trace[95728748] 'process raft request' (duration: 273.507927ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.799476Z","caller":"traceutil/trace.go:171","msg":"trace[1331526364] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"275.235034ms","start":"2026-07-01T09:28:48.524197Z","end":"2026-07-01T09:28:48.799432Z","steps":["trace[1331526364] 'process raft request' (duration: 274.964157ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.799607Z","caller":"traceutil/trace.go:171","msg":"trace[178943758] transaction","detail":"{read_only:false; number_of_response:0; response_revision:21; }","duration":"275.48838ms","start":"2026-07-01T09:28:48.524106Z","end":"2026-07-01T09:28:48.799594Z","steps":["trace[178943758] 'process raft request' (duration: 274.953976ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.799699Z","caller":"traceutil/trace.go:171","msg":"trace[182107552] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"276.245971ms","start":"2026-07-01T09:28:48.523443Z","end":"2026-07-01T09:28:48.799689Z","steps":["trace[182107552] 'process raft request' (duration: 275.533802ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.799722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.8602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.799831Z","caller":"traceutil/trace.go:171","msg":"trace[2010517301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24; }","duration":"276.025445ms","start":"2026-07-01T09:28:48.523768Z","end":"2026-07-01T09:28:48.799793Z","steps":["trace[2010517301] 'agreement among raft nodes before linearized reading' (duration: 275.788948ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.799991Z","caller":"traceutil/trace.go:171","msg":"trace[510180382] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"275.82156ms","start":"2026-07-01T09:28:48.524154Z","end":"2026-07-01T09:28:48.799976Z","steps":["trace[510180382] 'process raft request' (duration: 274.940006ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.800182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.820938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.800227Z","caller":"traceutil/trace.go:171","msg":"trace[72042562] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:24; }","duration":"228.915421ms","start":"2026-07-01T09:28:48.5713Z","end":"2026-07-01T09:28:48.800215Z","steps":["trace[72042562] 'agreement among raft nodes before linearized reading' (duration: 228.824929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.800588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.533658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-07-01T09:28:48.80063Z","caller":"traceutil/trace.go:171","msg":"trace[1937471435] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:24; }","duration":"218.603179ms","start":"2026-07-01T09:28:48.582016Z","end":"2026-07-01T09:28:48.80062Z","steps":["trace[1937471435] 'agreement among raft nodes before linearized reading' (duration: 218.527157ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.80079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.310949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.800845Z","caller":"traceutil/trace.go:171","msg":"trace[1062512062] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:24; }","duration":"219.396351ms","start":"2026-07-01T09:28:48.581433Z","end":"2026-07-01T09:28:48.800829Z","steps":["trace[1062512062] 'agreement among raft nodes before linearized reading' (duration: 219.280708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:48.801099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.127324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-07-01T09:28:48.801118Z","caller":"traceutil/trace.go:171","msg":"trace[135562832] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"276.164209ms","start":"2026-07-01T09:28:48.523189Z","end":"2026-07-01T09:28:48.799353Z","steps":["trace[135562832] 'process raft request' (duration: 275.611514ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:48.801139Z","caller":"traceutil/trace.go:171","msg":"trace[767832484] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:24; }","duration":"219.177835ms","start":"2026-07-01T09:28:48.581951Z","end":"2026-07-01T09:28:48.801129Z","steps":["trace[767832484] 'agreement among raft nodes before linearized reading' (duration: 219.118944ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:52.904073Z","caller":"traceutil/trace.go:171","msg":"trace[831355542] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"104.020706ms","start":"2026-07-01T09:28:52.800028Z","end":"2026-07-01T09:28:52.904049Z","steps":["trace[831355542] 'process raft request' (duration: 103.827131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:52.966719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.557659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"warn","ts":"2026-07-01T09:28:52.966496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.298212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-07-01T09:28:52.966794Z","caller":"traceutil/trace.go:171","msg":"trace[1312150196] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:306; }","duration":"112.654601ms","start":"2026-07-01T09:28:52.854121Z","end":"2026-07-01T09:28:52.966775Z","steps":["trace[1312150196] 'agreement among raft nodes before linearized reading' (duration: 112.504527ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:52.966764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.62845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5890"} {"level":"info","ts":"2026-07-01T09:28:52.966882Z","caller":"traceutil/trace.go:171","msg":"trace[1755268256] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:306; }","duration":"112.655311ms","start":"2026-07-01T09:28:52.854155Z","end":"2026-07-01T09:28:52.96681Z","steps":["trace[1755268256] 'agreement among raft nodes before linearized reading' (duration: 112.2526ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:52.966898Z","caller":"traceutil/trace.go:171","msg":"trace[2000158295] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:306; }","duration":"112.808136ms","start":"2026-07-01T09:28:52.854062Z","end":"2026-07-01T09:28:52.96687Z","steps":["trace[2000158295] 'agreement among raft nodes before linearized reading' (duration: 112.59458ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:57.962061Z","caller":"traceutil/trace.go:171","msg":"trace[2000560314] linearizableReadLoop","detail":"{readStateIndex:383; appliedIndex:382; }","duration":"169.248498ms","start":"2026-07-01T09:28:57.792785Z","end":"2026-07-01T09:28:57.962034Z","steps":["trace[2000560314] 'read index received' (duration: 169.003711ms)","trace[2000560314] 'applied index is now lower than readState.Index' (duration: 243.837µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:28:57.962188Z","caller":"traceutil/trace.go:171","msg":"trace[1057051680] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"206.600928ms","start":"2026-07-01T09:28:57.755567Z","end":"2026-07-01T09:28:57.962168Z","steps":["trace[1057051680] 'process raft request' (duration: 206.338411ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:57.962268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.462014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-07-01T09:28:57.962321Z","caller":"traceutil/trace.go:171","msg":"trace[188744689] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:368; }","duration":"169.561407ms","start":"2026-07-01T09:28:57.792745Z","end":"2026-07-01T09:28:57.962306Z","steps":["trace[188744689] 'agreement among raft nodes before linearized reading' (duration: 169.439973ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:28:57.962582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.174599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-01T09:28:57.96267Z","caller":"traceutil/trace.go:171","msg":"trace[785559720] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:368; }","duration":"120.290432ms","start":"2026-07-01T09:28:57.842365Z","end":"2026-07-01T09:28:57.962656Z","steps":["trace[785559720] 'agreement among raft nodes before linearized reading' (duration: 120.130798ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:58.15202Z","caller":"traceutil/trace.go:171","msg":"trace[1343253968] linearizableReadLoop","detail":"{readStateIndex:384; appliedIndex:383; }","duration":"185.867991ms","start":"2026-07-01T09:28:57.966127Z","end":"2026-07-01T09:28:58.151995Z","steps":["trace[1343253968] 'read index received' (duration: 185.628695ms)","trace[1343253968] 'applied index is now lower than readState.Index' (duration: 238.316µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:28:58.152143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.995704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-01T09:28:58.152184Z","caller":"traceutil/trace.go:171","msg":"trace[21207594] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:369; }","duration":"186.086097ms","start":"2026-07-01T09:28:57.966088Z","end":"2026-07-01T09:28:58.152174Z","steps":["trace[21207594] 'agreement among raft nodes before linearized reading' (duration: 185.998445ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:58.152169Z","caller":"traceutil/trace.go:171","msg":"trace[31220387] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"186.030275ms","start":"2026-07-01T09:28:57.966087Z","end":"2026-07-01T09:28:58.152117Z","steps":["trace[31220387] 'process raft request' (duration: 185.779789ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:58.156283Z","caller":"traceutil/trace.go:171","msg":"trace[1979901119] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"189.711686ms","start":"2026-07-01T09:28:57.966551Z","end":"2026-07-01T09:28:58.156263Z","steps":["trace[1979901119] 'process raft request' (duration: 189.551192ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:58.156316Z","caller":"traceutil/trace.go:171","msg":"trace[1506133207] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"187.630439ms","start":"2026-07-01T09:28:57.968668Z","end":"2026-07-01T09:28:58.156298Z","steps":["trace[1506133207] 'process raft request' (duration: 187.581588ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:28:58.156633Z","caller":"traceutil/trace.go:171","msg":"trace[1171800102] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"189.835269ms","start":"2026-07-01T09:28:57.966786Z","end":"2026-07-01T09:28:58.156621Z","steps":["trace[1171800102] 'process raft request' (duration: 189.417338ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:11.056996Z","caller":"traceutil/trace.go:171","msg":"trace[1027660799] linearizableReadLoop","detail":"{readStateIndex:448; appliedIndex:447; }","duration":"153.705284ms","start":"2026-07-01T09:29:10.90326Z","end":"2026-07-01T09:29:11.056965Z","steps":["trace[1027660799] 'read index received' (duration: 153.456657ms)","trace[1027660799] 'applied index is now lower than readState.Index' (duration: 247.477µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:11.057114Z","caller":"traceutil/trace.go:171","msg":"trace[744579769] transaction","detail":"{read_only:false; response_revision:429; number_of_response:1; }","duration":"408.601228ms","start":"2026-07-01T09:29:10.648479Z","end":"2026-07-01T09:29:11.057081Z","steps":["trace[744579769] 'process raft request' (duration: 408.330431ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:11.05717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.892149ms","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-07-01T09:29:11.057217Z","caller":"traceutil/trace.go:171","msg":"trace[1493852299] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:429; }","duration":"153.992891ms","start":"2026-07-01T09:29:10.90321Z","end":"2026-07-01T09:29:11.057203Z","steps":["trace[1493852299] 'agreement among raft nodes before linearized reading' (duration: 153.889509ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:11.057506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:10.648455Z","time spent":"408.738872ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:29:11.564721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.826309ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:29:11.564822Z","caller":"traceutil/trace.go:171","msg":"trace[1582111384] linearizableReadLoop","detail":"{readStateIndex:449; appliedIndex:448; }","duration":"470.516148ms","start":"2026-07-01T09:29:11.09429Z","end":"2026-07-01T09:29:11.564806Z","steps":["trace[1582111384] 'read index received' (duration: 114.455093ms)","trace[1582111384] 'applied index is now lower than readState.Index' (duration: 356.060095ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:11.56491Z","caller":"traceutil/trace.go:171","msg":"trace[526804179] transaction","detail":"{read_only:false; response_revision:430; number_of_response:1; }","duration":"503.152218ms","start":"2026-07-01T09:29:11.061689Z","end":"2026-07-01T09:29:11.564841Z","steps":["trace[526804179] 'process raft request' (duration: 147.137675ms)","trace[526804179] 'compare' (duration: 355.709665ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:11.565055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.709243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-01T09:29:11.564955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.571147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-01T09:29:11.565147Z","caller":"traceutil/trace.go:171","msg":"trace[596899029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:430; }","duration":"470.888608ms","start":"2026-07-01T09:29:11.094238Z","end":"2026-07-01T09:29:11.565126Z","steps":["trace[596899029] 'agreement among raft nodes before linearized reading' (duration: 470.637701ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:11.565151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:11.061648Z","time spent":"503.415305ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:11.565167Z","caller":"traceutil/trace.go:171","msg":"trace[218485533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:430; }","duration":"445.807463ms","start":"2026-07-01T09:29:11.119346Z","end":"2026-07-01T09:29:11.565153Z","steps":["trace[218485533] 'agreement among raft nodes before linearized reading' (duration: 445.560817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:11.565192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:11.094217Z","time spent":"470.96718ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T09:29:11.565211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:11.119331Z","time spent":"445.869816ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T09:29:11.564967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.05942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:11.565333Z","caller":"traceutil/trace.go:171","msg":"trace[1371941210] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:430; }","duration":"148.454531ms","start":"2026-07-01T09:29:11.416864Z","end":"2026-07-01T09:29:11.565318Z","steps":["trace[1371941210] 'agreement among raft nodes before linearized reading' (duration: 148.06179ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:12.78276Z","caller":"traceutil/trace.go:171","msg":"trace[721173282] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"266.907461ms","start":"2026-07-01T09:29:12.515824Z","end":"2026-07-01T09:29:12.782731Z","steps":["trace[721173282] 'process raft request' (duration: 266.770677ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:21.806441Z","caller":"traceutil/trace.go:171","msg":"trace[2027991569] linearizableReadLoop","detail":"{readStateIndex:505; appliedIndex:504; }","duration":"139.950739ms","start":"2026-07-01T09:29:21.666426Z","end":"2026-07-01T09:29:21.806376Z","steps":["trace[2027991569] 'read index received' (duration: 139.770004ms)","trace[2027991569] 'applied index is now lower than readState.Index' (duration: 179.685µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:21.806505Z","caller":"traceutil/trace.go:171","msg":"trace[2035872371] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"187.199577ms","start":"2026-07-01T09:29:21.619281Z","end":"2026-07-01T09:29:21.806481Z","steps":["trace[2035872371] 'process raft request' (duration: 186.973071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:21.806732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.255707ms","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-07-01T09:29:21.806756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.621635ms","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-07-01T09:29:21.806846Z","caller":"traceutil/trace.go:171","msg":"trace[110343008] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:482; }","duration":"140.416891ms","start":"2026-07-01T09:29:21.666413Z","end":"2026-07-01T09:29:21.80683Z","steps":["trace[110343008] 'agreement among raft nodes before linearized reading' (duration: 140.209575ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:21.807011Z","caller":"traceutil/trace.go:171","msg":"trace[282739498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:482; }","duration":"122.882722ms","start":"2026-07-01T09:29:21.684104Z","end":"2026-07-01T09:29:21.806987Z","steps":["trace[282739498] 'agreement among raft nodes before linearized reading' (duration: 122.483441ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.641493Z","caller":"traceutil/trace.go:171","msg":"trace[290575980] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"125.74437ms","start":"2026-07-01T09:29:26.515721Z","end":"2026-07-01T09:29:26.641466Z","steps":["trace[290575980] 'process raft request' (duration: 123.780017ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.645058Z","caller":"traceutil/trace.go:171","msg":"trace[736536446] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"123.823418ms","start":"2026-07-01T09:29:26.521222Z","end":"2026-07-01T09:29:26.645046Z","steps":["trace[736536446] 'process raft request' (duration: 123.275403ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.645163Z","caller":"traceutil/trace.go:171","msg":"trace[1027759626] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"123.87523ms","start":"2026-07-01T09:29:26.521281Z","end":"2026-07-01T09:29:26.645156Z","steps":["trace[1027759626] 'process raft request' (duration: 123.265453ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.645238Z","caller":"traceutil/trace.go:171","msg":"trace[362232029] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"111.618825ms","start":"2026-07-01T09:29:26.533613Z","end":"2026-07-01T09:29:26.645232Z","steps":["trace[362232029] 'process raft request' (duration: 110.962757ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.645641Z","caller":"traceutil/trace.go:171","msg":"trace[1645939696] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"109.812686ms","start":"2026-07-01T09:29:26.535819Z","end":"2026-07-01T09:29:26.645631Z","steps":["trace[1645939696] 'process raft request' (duration: 108.84028ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.645698Z","caller":"traceutil/trace.go:171","msg":"trace[873482655] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"110.739442ms","start":"2026-07-01T09:29:26.534953Z","end":"2026-07-01T09:29:26.645692Z","steps":["trace[873482655] 'process raft request' (duration: 109.653722ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.645749Z","caller":"traceutil/trace.go:171","msg":"trace[1220898302] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"105.92171ms","start":"2026-07-01T09:29:26.539809Z","end":"2026-07-01T09:29:26.645731Z","steps":["trace[1220898302] 'process raft request' (duration: 104.911182ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:26.645772Z","caller":"traceutil/trace.go:171","msg":"trace[1657405667] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"110.608528ms","start":"2026-07-01T09:29:26.535157Z","end":"2026-07-01T09:29:26.645766Z","steps":["trace[1657405667] 'process raft request' (duration: 109.476457ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.540042Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605637715449004,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-01T09:29:27.65535Z","caller":"traceutil/trace.go:171","msg":"trace[1369192920] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"757.610281ms","start":"2026-07-01T09:29:26.897153Z","end":"2026-07-01T09:29:27.654764Z","steps":["trace[1369192920] 'process raft request' (duration: 754.485135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.656164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:26.897051Z","time spent":"758.394582ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:27.660974Z","caller":"traceutil/trace.go:171","msg":"trace[1145775522] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:597; }","duration":"621.342833ms","start":"2026-07-01T09:29:27.039599Z","end":"2026-07-01T09:29:27.660942Z","steps":["trace[1145775522] 'read index received' (duration: 612.001318ms)","trace[1145775522] 'applied index is now lower than readState.Index' (duration: 9.340525ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:27.661179Z","caller":"traceutil/trace.go:171","msg":"trace[20853415] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"744.358359ms","start":"2026-07-01T09:29:26.916769Z","end":"2026-07-01T09:29:27.661127Z","steps":["trace[20853415] 'process raft request' (duration: 744.076342ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.620931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.66129Z","caller":"traceutil/trace.go:171","msg":"trace[1390151268] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"621.714973ms","start":"2026-07-01T09:29:27.039561Z","end":"2026-07-01T09:29:27.661276Z","steps":["trace[1390151268] 'agreement among raft nodes before linearized reading' (duration: 621.59901ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:26.916745Z","time spent":"744.507403ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T09:29:27.661326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.039541Z","time spent":"621.773834ms","remote":"127.0.0.1:55148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-01T09:29:27.661384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.687903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.661439Z","caller":"traceutil/trace.go:171","msg":"trace[618951335] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"621.752564ms","start":"2026-07-01T09:29:27.039671Z","end":"2026-07-01T09:29:27.661423Z","steps":["trace[618951335] 'agreement among raft nodes before linearized reading' (duration: 621.652112ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.937688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.661512Z","caller":"traceutil/trace.go:171","msg":"trace[1857247075] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:573; }","duration":"486.002049ms","start":"2026-07-01T09:29:27.175501Z","end":"2026-07-01T09:29:27.661503Z","steps":["trace[1857247075] 'agreement among raft nodes before linearized reading' (duration: 485.920817ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.175496Z","time spent":"486.035ms","remote":"127.0.0.1:55188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.661602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.039648Z","time spent":"621.818195ms","remote":"127.0.0.1:55148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.661641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.798457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.661675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.98891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.661679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.833488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.661698Z","caller":"traceutil/trace.go:171","msg":"trace[1816907103] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:573; }","duration":"449.023731ms","start":"2026-07-01T09:29:27.212666Z","end":"2026-07-01T09:29:27.66169Z","steps":["trace[1816907103] 'agreement among raft nodes before linearized reading' (duration: 448.98822ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:27.661704Z","caller":"traceutil/trace.go:171","msg":"trace[1918057234] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:573; }","duration":"543.873438ms","start":"2026-07-01T09:29:27.117811Z","end":"2026-07-01T09:29:27.661685Z","steps":["trace[1918057234] 'agreement among raft nodes before linearized reading' (duration: 543.762485ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.212659Z","time spent":"449.052232ms","remote":"127.0.0.1:55198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.661743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.117806Z","time spent":"543.927181ms","remote":"127.0.0.1:55178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.661751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.035362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.661776Z","caller":"traceutil/trace.go:171","msg":"trace[131786143] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:573; }","duration":"316.070713ms","start":"2026-07-01T09:29:27.345698Z","end":"2026-07-01T09:29:27.661768Z","steps":["trace[131786143] 'agreement among raft nodes before linearized reading' (duration: 316.032722ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.345691Z","time spent":"316.102964ms","remote":"127.0.0.1:55208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.661816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.009778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.661824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.020953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.661836Z","caller":"traceutil/trace.go:171","msg":"trace[544175069] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:573; }","duration":"450.029698ms","start":"2026-07-01T09:29:27.2118Z","end":"2026-07-01T09:29:27.66183Z","steps":["trace[544175069] 'agreement among raft nodes before linearized reading' (duration: 449.999628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.211777Z","time spent":"450.073869ms","remote":"127.0.0.1:55198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-07-01T09:29:27.661857Z","caller":"traceutil/trace.go:171","msg":"trace[1781514151] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:573; }","duration":"544.069454ms","start":"2026-07-01T09:29:27.117778Z","end":"2026-07-01T09:29:27.661847Z","steps":["trace[1781514151] 'agreement among raft nodes before linearized reading' (duration: 544.015002ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.117769Z","time spent":"544.118416ms","remote":"127.0.0.1:55178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-01T09:29:27.661939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.250034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.661957Z","caller":"traceutil/trace.go:171","msg":"trace[1579906262] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:573; }","duration":"450.282815ms","start":"2026-07-01T09:29:27.211669Z","end":"2026-07-01T09:29:27.661952Z","steps":["trace[1579906262] 'agreement among raft nodes before linearized reading' (duration: 450.255584ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.906616ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.661975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.21166Z","time spent":"450.310066ms","remote":"127.0.0.1:55198","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 "} {"level":"info","ts":"2026-07-01T09:29:27.661988Z","caller":"traceutil/trace.go:171","msg":"trace[193773143] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:573; }","duration":"316.953387ms","start":"2026-07-01T09:29:27.345026Z","end":"2026-07-01T09:29:27.661979Z","steps":["trace[193773143] 'agreement among raft nodes before linearized reading' (duration: 316.903626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.661998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.903502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.662016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.345017Z","time spent":"316.990168ms","remote":"127.0.0.1:55208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-07-01T09:29:27.662029Z","caller":"traceutil/trace.go:171","msg":"trace[316468385] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:573; }","duration":"568.943153ms","start":"2026-07-01T09:29:27.093078Z","end":"2026-07-01T09:29:27.662021Z","steps":["trace[316468385] 'agreement among raft nodes before linearized reading' (duration: 568.888991ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.771071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.662057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.093072Z","time spent":"568.978373ms","remote":"127.0.0.1:55176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.662087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.621476ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.662085Z","caller":"traceutil/trace.go:171","msg":"trace[1466135226] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:573; }","duration":"486.839212ms","start":"2026-07-01T09:29:27.175235Z","end":"2026-07-01T09:29:27.662074Z","steps":["trace[1466135226] 'agreement among raft nodes before linearized reading' (duration: 486.77119ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:27.662106Z","caller":"traceutil/trace.go:171","msg":"trace[348035948] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:573; }","duration":"464.649627ms","start":"2026-07-01T09:29:27.19745Z","end":"2026-07-01T09:29:27.6621Z","steps":["trace[348035948] 'agreement among raft nodes before linearized reading' (duration: 464.620046ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.197444Z","time spent":"464.675728ms","remote":"127.0.0.1:55196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.66213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.175218Z","time spent":"486.898984ms","remote":"127.0.0.1:55188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-01T09:29:27.66217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.894182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.662194Z","caller":"traceutil/trace.go:171","msg":"trace[1101055310] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"336.941123ms","start":"2026-07-01T09:29:27.325245Z","end":"2026-07-01T09:29:27.662186Z","steps":["trace[1101055310] 'agreement among raft nodes before linearized reading' (duration: 336.909322ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662207Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.870428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.662217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.785791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:29:27.662223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.325229Z","time spent":"336.983384ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T09:29:27.662238Z","caller":"traceutil/trace.go:171","msg":"trace[960193738] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:573; }","duration":"464.831842ms","start":"2026-07-01T09:29:27.197401Z","end":"2026-07-01T09:29:27.662233Z","steps":["trace[960193738] 'agreement among raft nodes before linearized reading' (duration: 464.799792ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:27.662236Z","caller":"traceutil/trace.go:171","msg":"trace[1043975179] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:573; }","duration":"569.93747ms","start":"2026-07-01T09:29:27.092291Z","end":"2026-07-01T09:29:27.662229Z","steps":["trace[1043975179] 'agreement among raft nodes before linearized reading' (duration: 569.893459ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.19739Z","time spent":"464.862203ms","remote":"127.0.0.1:55196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-07-01T09:29:27.662266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.092269Z","time spent":"569.990311ms","remote":"127.0.0.1:55176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 "} {"level":"info","ts":"2026-07-01T09:29:27.661714Z","caller":"traceutil/trace.go:171","msg":"trace[1863810676] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:573; }","duration":"425.882079ms","start":"2026-07-01T09:29:27.235821Z","end":"2026-07-01T09:29:27.661703Z","steps":["trace[1863810676] 'agreement among raft nodes before linearized reading' (duration: 425.824337ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.235814Z","time spent":"426.526007ms","remote":"127.0.0.1:55200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-01T09:29:27.662345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.196188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.662376Z","caller":"traceutil/trace.go:171","msg":"trace[290407553] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:573; }","duration":"426.229469ms","start":"2026-07-01T09:29:27.236138Z","end":"2026-07-01T09:29:27.662367Z","steps":["trace[290407553] 'agreement among raft nodes before linearized reading' (duration: 426.181918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.136845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.662411Z","caller":"traceutil/trace.go:171","msg":"trace[1719287965] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:573; }","duration":"570.176246ms","start":"2026-07-01T09:29:27.092227Z","end":"2026-07-01T09:29:27.662404Z","steps":["trace[1719287965] 'agreement among raft nodes before linearized reading' (duration: 570.135625ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.09222Z","time spent":"570.210988ms","remote":"127.0.0.1:55176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.662511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.940765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.662612Z","caller":"traceutil/trace.go:171","msg":"trace[507906995] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"594.054928ms","start":"2026-07-01T09:29:27.068536Z","end":"2026-07-01T09:29:27.662591Z","steps":["trace[507906995] 'agreement among raft nodes before linearized reading' (duration: 593.918484ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.06853Z","time spent":"594.11699ms","remote":"127.0.0.1:55148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.662914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.135531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.662971Z","caller":"traceutil/trace.go:171","msg":"trace[195431868] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"594.195212ms","start":"2026-07-01T09:29:27.068761Z","end":"2026-07-01T09:29:27.662956Z","steps":["trace[195431868] 'agreement among raft nodes before linearized reading' (duration: 594.10826ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.662989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.056692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.663021Z","caller":"traceutil/trace.go:171","msg":"trace[972564182] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:573; }","duration":"427.126244ms","start":"2026-07-01T09:29:27.235884Z","end":"2026-07-01T09:29:27.66301Z","steps":["trace[972564182] 'agreement among raft nodes before linearized reading' (duration: 427.070272ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.663019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.06874Z","time spent":"594.263544ms","remote":"127.0.0.1:55160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.663038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.236113Z","time spent":"426.893967ms","remote":"127.0.0.1:55200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.662137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.114142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.664999Z","caller":"traceutil/trace.go:171","msg":"trace[190312738] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:573; }","duration":"319.97858ms","start":"2026-07-01T09:29:27.345006Z","end":"2026-07-01T09:29:27.664985Z","steps":["trace[190312738] 'agreement among raft nodes before linearized reading' (duration: 317.106291ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.665032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.344996Z","time spent":"320.026052ms","remote":"127.0.0.1:55208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.662054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.456402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.665136Z","caller":"traceutil/trace.go:171","msg":"trace[652458699] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:573; }","duration":"467.556526ms","start":"2026-07-01T09:29:27.197573Z","end":"2026-07-01T09:29:27.66513Z","steps":["trace[652458699] 'agreement among raft nodes before linearized reading' (duration: 464.465572ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.665158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.197563Z","time spent":"467.587847ms","remote":"127.0.0.1:55196","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.66305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.235864Z","time spent":"427.179355ms","remote":"127.0.0.1:55200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.663176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.498566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.665345Z","caller":"traceutil/trace.go:171","msg":"trace[47120604] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:573; }","duration":"524.681945ms","start":"2026-07-01T09:29:27.140656Z","end":"2026-07-01T09:29:27.665338Z","steps":["trace[47120604] 'agreement among raft nodes before linearized reading' (duration: 522.502636ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.665368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.140649Z","time spent":"524.711446ms","remote":"127.0.0.1:55182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.663203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.700501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.665539Z","caller":"traceutil/trace.go:171","msg":"trace[1575562325] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:573; }","duration":"525.035865ms","start":"2026-07-01T09:29:27.140497Z","end":"2026-07-01T09:29:27.665533Z","steps":["trace[1575562325] 'agreement among raft nodes before linearized reading' (duration: 522.694061ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.665563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.140471Z","time spent":"525.084626ms","remote":"127.0.0.1:55182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:29:27.663225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.953188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.665687Z","caller":"traceutil/trace.go:171","msg":"trace[1063634210] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:573; }","duration":"525.429826ms","start":"2026-07-01T09:29:27.140251Z","end":"2026-07-01T09:29:27.665681Z","steps":["trace[1063634210] 'agreement among raft nodes before linearized reading' (duration: 522.961348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.665709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.140241Z","time spent":"525.461386ms","remote":"127.0.0.1:55182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-07-01T09:29:27.663247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.550477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.665819Z","caller":"traceutil/trace.go:171","msg":"trace[1211275823] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:573; }","duration":"547.122187ms","start":"2026-07-01T09:29:27.118692Z","end":"2026-07-01T09:29:27.665814Z","steps":["trace[1211275823] 'agreement among raft nodes before linearized reading' (duration: 544.542237ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.66584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.118676Z","time spent":"547.157749ms","remote":"127.0.0.1:55178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 "} {"level":"warn","ts":"2026-07-01T09:29:27.663257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.637964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:27.66594Z","caller":"traceutil/trace.go:171","msg":"trace[176845666] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:573; }","duration":"597.341008ms","start":"2026-07-01T09:29:27.068592Z","end":"2026-07-01T09:29:27.665933Z","steps":["trace[176845666] 'agreement among raft nodes before linearized reading' (duration: 594.622714ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.665964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.068588Z","time spent":"597.367879ms","remote":"127.0.0.1:55160","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-07-01T09:29:27.664052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.755598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-01T09:29:27.666046Z","caller":"traceutil/trace.go:171","msg":"trace[502651763] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"515.775122ms","start":"2026-07-01T09:29:27.150266Z","end":"2026-07-01T09:29:27.666041Z","steps":["trace[502651763] 'agreement among raft nodes before linearized reading' (duration: 513.718776ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:27.666065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.150255Z","time spent":"515.804303ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T09:29:28.432801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.584004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:29:28.432897Z","caller":"traceutil/trace.go:171","msg":"trace[430458463] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"727.659835ms","start":"2026-07-01T09:29:27.705221Z","end":"2026-07-01T09:29:28.432881Z","steps":["trace[430458463] 'process raft request' (duration: 151.926556ms)","trace[430458463] 'compare' (duration: 575.305497ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:28.432955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.705203Z","time spent":"727.724516ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:28.720356Z","caller":"traceutil/trace.go:171","msg":"trace[1725017531] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.00274396s","start":"2026-07-01T09:29:27.717338Z","end":"2026-07-01T09:29:28.720332Z","steps":["trace[1725017531] 'process raft request' (duration: 981.110779ms)","trace[1725017531] 'compare' (duration: 21.393764ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:28.720517Z","caller":"traceutil/trace.go:171","msg":"trace[597270961] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:600; }","duration":"888.722599ms","start":"2026-07-01T09:29:27.83177Z","end":"2026-07-01T09:29:28.720493Z","steps":["trace[597270961] 'read index received' (duration: 25.469515ms)","trace[597270961] 'applied index is now lower than readState.Index' (duration: 863.251364ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:28.720551Z","caller":"traceutil/trace.go:171","msg":"trace[403072526] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"990.190317ms","start":"2026-07-01T09:29:27.730349Z","end":"2026-07-01T09:29:28.72054Z","steps":["trace[403072526] 'process raft request' (duration: 989.93194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:28.720614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.717314Z","time spent":"1.003109559s","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:29:28.720681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.730319Z","time spent":"990.300411ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T09:29:28.720758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"888.955805ms","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-07-01T09:29:28.720836Z","caller":"traceutil/trace.go:171","msg":"trace[221190724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"889.083359ms","start":"2026-07-01T09:29:27.831735Z","end":"2026-07-01T09:29:28.720819Z","steps":["trace[221190724] 'agreement among raft nodes before linearized reading' (duration: 888.844283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:28.720912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.831719Z","time spent":"889.153381ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T09:29:28.931646Z","caller":"traceutil/trace.go:171","msg":"trace[892348349] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"211.036858ms","start":"2026-07-01T09:29:28.720584Z","end":"2026-07-01T09:29:28.931621Z","steps":["trace[892348349] 'read index received' (duration: 204.868929ms)","trace[892348349] 'applied index is now lower than readState.Index' (duration: 6.167099ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:28.93177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.059997182s","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-07-01T09:29:28.931736Z","caller":"traceutil/trace.go:171","msg":"trace[1015801514] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"484.708955ms","start":"2026-07-01T09:29:28.446998Z","end":"2026-07-01T09:29:28.931707Z","steps":["trace[1015801514] 'process raft request' (duration: 478.422103ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:28.931793Z","caller":"traceutil/trace.go:171","msg":"trace[237915044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:578; }","duration":"1.060063994s","start":"2026-07-01T09:29:27.871723Z","end":"2026-07-01T09:29:28.931787Z","steps":["trace[237915044] 'agreement among raft nodes before linearized reading' (duration: 1.059985552s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:28.931819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.871709Z","time spent":"1.060104725s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T09:29:28.931909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:28.446979Z","time spent":"484.842329ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:29:28.931998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"606.55446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:28.932025Z","caller":"traceutil/trace.go:171","msg":"trace[2111881089] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"606.605882ms","start":"2026-07-01T09:29:28.325414Z","end":"2026-07-01T09:29:28.93202Z","steps":["trace[2111881089] 'agreement among raft nodes before linearized reading' (duration: 606.568531ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:28.932041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:28.325386Z","time spent":"606.651852ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T09:29:28.93215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060388733s","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-07-01T09:29:28.932175Z","caller":"traceutil/trace.go:171","msg":"trace[428382628] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:578; }","duration":"1.060435044s","start":"2026-07-01T09:29:27.871735Z","end":"2026-07-01T09:29:28.93217Z","steps":["trace[428382628] 'agreement among raft nodes before linearized reading' (duration: 1.060396373s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:28.932191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:27.871723Z","time spent":"1.060464465s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-01T09:29:28.933032Z","caller":"traceutil/trace.go:171","msg":"trace[376012183] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"206.076293ms","start":"2026-07-01T09:29:28.726947Z","end":"2026-07-01T09:29:28.933023Z","steps":["trace[376012183] 'process raft request' (duration: 205.648441ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:28.933777Z","caller":"traceutil/trace.go:171","msg":"trace[1973983755] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"184.806462ms","start":"2026-07-01T09:29:28.748961Z","end":"2026-07-01T09:29:28.933768Z","steps":["trace[1973983755] 'process raft request' (duration: 183.695942ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:28.934075Z","caller":"traceutil/trace.go:171","msg":"trace[1970034064] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"146.97645ms","start":"2026-07-01T09:29:28.787073Z","end":"2026-07-01T09:29:28.934049Z","steps":["trace[1970034064] 'process raft request' (duration: 146.767334ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:30.033962Z","caller":"traceutil/trace.go:171","msg":"trace[1933733875] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"344.715716ms","start":"2026-07-01T09:29:29.689216Z","end":"2026-07-01T09:29:30.033932Z","steps":["trace[1933733875] 'process raft request' (duration: 332.908633ms)","trace[1933733875] 'compare' (duration: 11.429282ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:30.034118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:29.689198Z","time spent":"344.839879ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:30.034346Z","caller":"traceutil/trace.go:171","msg":"trace[748015493] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"343.557644ms","start":"2026-07-01T09:29:29.690758Z","end":"2026-07-01T09:29:30.034315Z","steps":["trace[748015493] 'process raft request' (duration: 343.002819ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:30.034381Z","caller":"traceutil/trace.go:171","msg":"trace[1803832406] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:629; }","duration":"288.586484ms","start":"2026-07-01T09:29:29.745763Z","end":"2026-07-01T09:29:30.03435Z","steps":["trace[1803832406] 'read index received' (duration: 276.330149ms)","trace[1803832406] 'applied index is now lower than readState.Index' (duration: 12.255065ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:30.034489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:29.690746Z","time spent":"343.673658ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:30.03455Z","caller":"traceutil/trace.go:171","msg":"trace[1146698254] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"322.113419ms","start":"2026-07-01T09:29:29.712391Z","end":"2026-07-01T09:29:30.034504Z","steps":["trace[1146698254] 'process raft request' (duration: 321.633876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:30.034685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:29.712339Z","time spent":"322.254463ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:29:30.034786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.576907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-07-01T09:29:30.034821Z","caller":"traceutil/trace.go:171","msg":"trace[950772335] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:606; }","duration":"125.644048ms","start":"2026-07-01T09:29:29.909164Z","end":"2026-07-01T09:29:30.034809Z","steps":["trace[950772335] 'agreement among raft nodes before linearized reading' (duration: 125.555286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:30.035075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.306604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-07-01T09:29:30.035131Z","caller":"traceutil/trace.go:171","msg":"trace[1977926185] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:606; }","duration":"289.391836ms","start":"2026-07-01T09:29:29.745722Z","end":"2026-07-01T09:29:30.035114Z","steps":["trace[1977926185] 'agreement among raft nodes before linearized reading' (duration: 289.18737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:34.27079Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605637715449148,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-01T09:29:34.44776Z","caller":"traceutil/trace.go:171","msg":"trace[1124609497] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"677.783563ms","start":"2026-07-01T09:29:33.769951Z","end":"2026-07-01T09:29:34.447735Z","steps":["trace[1124609497] 'read index received' (duration: 676.996711ms)","trace[1124609497] 'applied index is now lower than readState.Index' (duration: 785.902µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:34.447895Z","caller":"traceutil/trace.go:171","msg":"trace[568025627] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"797.824938ms","start":"2026-07-01T09:29:33.65003Z","end":"2026-07-01T09:29:34.447854Z","steps":["trace[568025627] 'process raft request' (duration: 797.17653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:34.448077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:33.650008Z","time spent":"797.963802ms","remote":"127.0.0.1:58540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036217,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:29:34.448306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.196434ms","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-07-01T09:29:34.44836Z","caller":"traceutil/trace.go:171","msg":"trace[1567794445] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:631; }","duration":"678.43454ms","start":"2026-07-01T09:29:33.76991Z","end":"2026-07-01T09:29:34.448344Z","steps":["trace[1567794445] 'agreement among raft nodes before linearized reading' (duration: 677.999188ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:34.448401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:33.769893Z","time spent":"678.497773ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T09:29:34.448697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"605.349257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-6sqk4\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-07-01T09:29:34.448808Z","caller":"traceutil/trace.go:171","msg":"trace[681679324] range","detail":"{range_begin:/registry/pods/kube-system/cilium-6sqk4; range_end:; response_count:1; response_revision:631; }","duration":"605.515191ms","start":"2026-07-01T09:29:33.843264Z","end":"2026-07-01T09:29:34.448779Z","steps":["trace[681679324] 'agreement among raft nodes before linearized reading' (duration: 605.055629ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:34.448863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:33.843079Z","time spent":"605.769518ms","remote":"127.0.0.1:58640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16984,"request content":"key:\"/registry/pods/kube-system/cilium-6sqk4\" "} {"level":"info","ts":"2026-07-01T09:29:34.620614Z","caller":"traceutil/trace.go:171","msg":"trace[1188737280] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"166.679407ms","start":"2026-07-01T09:29:34.453906Z","end":"2026-07-01T09:29:34.620585Z","steps":["trace[1188737280] 'process raft request' (duration: 99.550996ms)","trace[1188737280] 'compare' (duration: 67.004237ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:34.691108Z","caller":"traceutil/trace.go:171","msg":"trace[1247962376] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"187.674989ms","start":"2026-07-01T09:29:34.503407Z","end":"2026-07-01T09:29:34.691082Z","steps":["trace[1247962376] 'process raft request' (duration: 187.462644ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:34.691147Z","caller":"traceutil/trace.go:171","msg":"trace[450035016] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"229.031008ms","start":"2026-07-01T09:29:34.462073Z","end":"2026-07-01T09:29:34.691104Z","steps":["trace[450035016] 'process raft request' (duration: 228.655668ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:35.825838Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605637715449158,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T09:29:36.326776Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605637715449158,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T09:29:36.492119Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.367122772s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T09:29:36.495262Z","caller":"traceutil/trace.go:171","msg":"trace[1873376806] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.37144245s","start":"2026-07-01T09:29:35.123023Z","end":"2026-07-01T09:29:36.494465Z","steps":["trace[1873376806] 'process raft request' (duration: 1.370013481s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:36.495661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:35.122988Z","time spent":"1.372458487s","remote":"127.0.0.1:58540","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036249,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:36.504969Z","caller":"traceutil/trace.go:171","msg":"trace[1455801222] linearizableReadLoop","detail":"{readStateIndex:666; appliedIndex:664; }","duration":"1.179669616s","start":"2026-07-01T09:29:35.3252Z","end":"2026-07-01T09:29:36.504869Z","steps":["trace[1455801222] 'read index received' (duration: 1.167118254s)","trace[1455801222] 'applied index is now lower than readState.Index' (duration: 12.549002ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:36.505292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179981615s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:36.505356Z","caller":"traceutil/trace.go:171","msg":"trace[421379381] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"1.180219792s","start":"2026-07-01T09:29:35.32512Z","end":"2026-07-01T09:29:36.50534Z","steps":["trace[421379381] 'agreement among raft nodes before linearized reading' (duration: 1.179972795s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:36.5055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:35.325088Z","time spent":"1.180399576s","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T09:29:37.132002Z","caller":"traceutil/trace.go:171","msg":"trace[1860614694] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"265.903306ms","start":"2026-07-01T09:29:36.866059Z","end":"2026-07-01T09:29:37.131962Z","steps":["trace[1860614694] 'process raft request' (duration: 243.605777ms)","trace[1860614694] 'compare' (duration: 21.453586ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:37.134707Z","caller":"traceutil/trace.go:171","msg":"trace[382278406] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:669; }","duration":"108.981354ms","start":"2026-07-01T09:29:37.0257Z","end":"2026-07-01T09:29:37.134681Z","steps":["trace[382278406] 'read index received' (duration: 84.063984ms)","trace[382278406] 'applied index is now lower than readState.Index' (duration: 24.91641ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:37.134882Z","caller":"traceutil/trace.go:171","msg":"trace[1245739758] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"153.705964ms","start":"2026-07-01T09:29:36.981148Z","end":"2026-07-01T09:29:37.134853Z","steps":["trace[1245739758] 'process raft request' (duration: 152.382737ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:37.135125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.411795ms","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-07-01T09:29:37.135527Z","caller":"traceutil/trace.go:171","msg":"trace[64271737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"109.538108ms","start":"2026-07-01T09:29:37.025639Z","end":"2026-07-01T09:29:37.135178Z","steps":["trace[64271737] 'agreement among raft nodes before linearized reading' (duration: 109.400955ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:37.485805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.865654ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:29:37.4859Z","caller":"traceutil/trace.go:171","msg":"trace[1712448486] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"270.776448ms","start":"2026-07-01T09:29:37.215107Z","end":"2026-07-01T09:29:37.485883Z","steps":["trace[1712448486] 'process raft request' (duration: 26.768011ms)","trace[1712448486] 'compare' (duration: 243.766811ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:37.83359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.08222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:29:37.833688Z","caller":"traceutil/trace.go:171","msg":"trace[1549667761] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"332.312458ms","start":"2026-07-01T09:29:37.50135Z","end":"2026-07-01T09:29:37.833662Z","steps":["trace[1549667761] 'read index received' (duration: 158.028402ms)","trace[1549667761] 'applied index is now lower than readState.Index' (duration: 174.283026ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:37.833781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.42178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:37.833814Z","caller":"traceutil/trace.go:171","msg":"trace[454513573] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:649; }","duration":"332.493733ms","start":"2026-07-01T09:29:37.501312Z","end":"2026-07-01T09:29:37.833805Z","steps":["trace[454513573] 'agreement among raft nodes before linearized reading' (duration: 332.40303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:37.833845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:37.501295Z","time spent":"332.542163ms","remote":"127.0.0.1:58704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-07-01T09:29:37.834013Z","caller":"traceutil/trace.go:171","msg":"trace[2045283471] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"560.816742ms","start":"2026-07-01T09:29:37.273115Z","end":"2026-07-01T09:29:37.833931Z","steps":["trace[2045283471] 'process raft request' (duration: 386.335311ms)","trace[2045283471] 'compare' (duration: 173.907085ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:37.834274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:37.27309Z","time spent":"561.065439ms","remote":"127.0.0.1:58524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T09:29:38.200221Z","caller":"traceutil/trace.go:171","msg":"trace[198059911] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"331.74847ms","start":"2026-07-01T09:29:37.86845Z","end":"2026-07-01T09:29:38.200198Z","steps":["trace[198059911] 'process raft request' (duration: 331.612037ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:38.200353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:37.86843Z","time spent":"331.853444ms","remote":"127.0.0.1:58640","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17412,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:38.386118Z","caller":"traceutil/trace.go:171","msg":"trace[253171536] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"159.613014ms","start":"2026-07-01T09:29:38.226477Z","end":"2026-07-01T09:29:38.38609Z","steps":["trace[253171536] 'process raft request' (duration: 158.851084ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:39.605689Z","caller":"traceutil/trace.go:171","msg":"trace[1238751721] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"611.644499ms","start":"2026-07-01T09:29:38.994032Z","end":"2026-07-01T09:29:39.605677Z","steps":["trace[1238751721] 'process raft request' (duration: 611.395672ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:39.605803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:38.994008Z","time spent":"611.726871ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T09:29:39.606062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.840643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-01T09:29:39.606147Z","caller":"traceutil/trace.go:171","msg":"trace[1229953653] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:683; }","duration":"453.970296ms","start":"2026-07-01T09:29:39.152155Z","end":"2026-07-01T09:29:39.606125Z","steps":["trace[1229953653] 'agreement among raft nodes before linearized reading' (duration: 453.712879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:39.606192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:39.152129Z","time spent":"454.052409ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-01T09:29:39.605598Z","caller":"traceutil/trace.go:171","msg":"trace[670013812] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:710; }","duration":"453.37259ms","start":"2026-07-01T09:29:39.152201Z","end":"2026-07-01T09:29:39.605573Z","steps":["trace[670013812] 'read index received' (duration: 453.122144ms)","trace[670013812] 'applied index is now lower than readState.Index' (duration: 249.586µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:39.639023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.748262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-01T09:29:39.639063Z","caller":"traceutil/trace.go:171","msg":"trace[1695635697] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:686; }","duration":"486.815113ms","start":"2026-07-01T09:29:39.152237Z","end":"2026-07-01T09:29:39.639052Z","steps":["trace[1695635697] 'agreement among raft nodes before linearized reading' (duration: 486.69725ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:39.639084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:39.15219Z","time spent":"486.889175ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T09:29:39.639248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"485.757054ms","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-07-01T09:29:39.639273Z","caller":"traceutil/trace.go:171","msg":"trace[124658748] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:686; }","duration":"485.798166ms","start":"2026-07-01T09:29:39.153468Z","end":"2026-07-01T09:29:39.639267Z","steps":["trace[124658748] 'agreement among raft nodes before linearized reading' (duration: 485.735074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:39.63929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:39.153456Z","time spent":"485.830706ms","remote":"127.0.0.1:58738","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-07-01T09:29:39.639391Z","caller":"traceutil/trace.go:171","msg":"trace[1419694683] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"244.623254ms","start":"2026-07-01T09:29:39.394736Z","end":"2026-07-01T09:29:39.639359Z","steps":["trace[1419694683] 'process raft request' (duration: 244.154821ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:39.63939Z","caller":"traceutil/trace.go:171","msg":"trace[1789655045] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"446.072501ms","start":"2026-07-01T09:29:39.193241Z","end":"2026-07-01T09:29:39.639313Z","steps":["trace[1789655045] 'process raft request' (duration: 445.570887ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:39.639566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:39.193209Z","time spent":"446.268866ms","remote":"127.0.0.1:58504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T09:29:45.891786Z","caller":"traceutil/trace.go:171","msg":"trace[1030217877] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"133.960125ms","start":"2026-07-01T09:29:45.757801Z","end":"2026-07-01T09:29:45.891761Z","steps":["trace[1030217877] 'process raft request' (duration: 129.905925ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:51.901336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.184388ms","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-07-01T09:29:51.901411Z","caller":"traceutil/trace.go:171","msg":"trace[598031986] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:795; }","duration":"113.306961ms","start":"2026-07-01T09:29:51.788088Z","end":"2026-07-01T09:29:51.901395Z","steps":["trace[598031986] 'range keys from in-memory index tree' (duration: 113.039114ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:52.051852Z","caller":"traceutil/trace.go:171","msg":"trace[1124349108] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"146.849537ms","start":"2026-07-01T09:29:51.904974Z","end":"2026-07-01T09:29:52.051823Z","steps":["trace[1124349108] 'process raft request' (duration: 110.985578ms)","trace[1124349108] 'compare' (duration: 35.757536ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:29:53.449083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605637715449496,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T09:29:53.846237Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.020796512s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-01T09:29:53.846393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"727.12159ms","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-07-01T09:29:53.846574Z","caller":"traceutil/trace.go:171","msg":"trace[1602014640] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:807; }","duration":"727.314015ms","start":"2026-07-01T09:29:53.11924Z","end":"2026-07-01T09:29:53.846554Z","steps":["trace[1602014640] 'range keys from in-memory index tree' (duration: 727.104459ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:53.847122Z","caller":"traceutil/trace.go:171","msg":"trace[510733791] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"1.02179389s","start":"2026-07-01T09:29:52.825316Z","end":"2026-07-01T09:29:53.84711Z","steps":["trace[510733791] 'process raft request' (duration: 1.021665926s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:53.847236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:52.825288Z","time spent":"1.021882252s","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4904,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:29:53.8683Z","caller":"traceutil/trace.go:171","msg":"trace[1640723648] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:841; }","duration":"919.496219ms","start":"2026-07-01T09:29:52.948782Z","end":"2026-07-01T09:29:53.868279Z","steps":["trace[1640723648] 'read index received' (duration: 898.607439ms)","trace[1640723648] 'applied index is now lower than readState.Index' (duration: 20.88745ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:53.868432Z","caller":"traceutil/trace.go:171","msg":"trace[1492434556] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"440.331655ms","start":"2026-07-01T09:29:53.428087Z","end":"2026-07-01T09:29:53.868419Z","steps":["trace[1492434556] 'process raft request' (duration: 440.092868ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:53.868533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:53.428059Z","time spent":"440.413396ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:29:53.868689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.394539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:29:53.868755Z","caller":"traceutil/trace.go:171","msg":"trace[664116287] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"542.497651ms","start":"2026-07-01T09:29:53.326242Z","end":"2026-07-01T09:29:53.868739Z","steps":["trace[664116287] 'agreement among raft nodes before linearized reading' (duration: 542.388138ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:53.868799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:53.326222Z","time spent":"542.565214ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T09:29:53.868936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.145056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wz9fq\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-07-01T09:29:53.868997Z","caller":"traceutil/trace.go:171","msg":"trace[1157597282] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wz9fq; range_end:; response_count:1; response_revision:809; }","duration":"920.238029ms","start":"2026-07-01T09:29:52.948741Z","end":"2026-07-01T09:29:53.868979Z","steps":["trace[1157597282] 'agreement among raft nodes before linearized reading' (duration: 920.098575ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:53.869038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:29:52.948721Z","time spent":"920.30789ms","remote":"127.0.0.1:58640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3987,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wz9fq\" "} {"level":"warn","ts":"2026-07-01T09:29:53.869035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.002661ms","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-07-01T09:29:53.86916Z","caller":"traceutil/trace.go:171","msg":"trace[689007067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"103.156805ms","start":"2026-07-01T09:29:53.765985Z","end":"2026-07-01T09:29:53.869142Z","steps":["trace[689007067] 'agreement among raft nodes before linearized reading' (duration: 102.94099ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:54.047926Z","caller":"traceutil/trace.go:171","msg":"trace[1352762802] transaction","detail":"{read_only:false; response_revision:810; number_of_response:1; }","duration":"174.180083ms","start":"2026-07-01T09:29:53.873712Z","end":"2026-07-01T09:29:54.047892Z","steps":["trace[1352762802] 'process raft request' (duration: 142.052256ms)","trace[1352762802] 'compare' (duration: 31.89722ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:54.049897Z","caller":"traceutil/trace.go:171","msg":"trace[985670392] transaction","detail":"{read_only:false; response_revision:811; number_of_response:1; }","duration":"174.339127ms","start":"2026-07-01T09:29:53.875525Z","end":"2026-07-01T09:29:54.049864Z","steps":["trace[985670392] 'process raft request' (duration: 174.169403ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:29:59.419551Z","caller":"traceutil/trace.go:171","msg":"trace[1265256529] linearizableReadLoop","detail":"{readStateIndex:900; appliedIndex:899; }","duration":"103.34033ms","start":"2026-07-01T09:29:59.316187Z","end":"2026-07-01T09:29:59.419528Z","steps":["trace[1265256529] 'read index received' (duration: 42.661914ms)","trace[1265256529] 'applied index is now lower than readState.Index' (duration: 60.677046ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:29:59.419589Z","caller":"traceutil/trace.go:171","msg":"trace[1908750392] transaction","detail":"{read_only:false; response_revision:866; number_of_response:1; }","duration":"107.485613ms","start":"2026-07-01T09:29:59.312068Z","end":"2026-07-01T09:29:59.419554Z","steps":["trace[1908750392] 'process raft request' (duration: 106.373653ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:29:59.419914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.7061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:10000 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-07-01T09:29:59.419966Z","caller":"traceutil/trace.go:171","msg":"trace[2022860953] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:866; }","duration":"103.820543ms","start":"2026-07-01T09:29:59.316132Z","end":"2026-07-01T09:29:59.419953Z","steps":["trace[2022860953] 'agreement among raft nodes before linearized reading' (duration: 103.495294ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:00.230781Z","caller":"traceutil/trace.go:171","msg":"trace[900975573] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"146.119088ms","start":"2026-07-01T09:30:00.08464Z","end":"2026-07-01T09:30:00.230759Z","steps":["trace[900975573] 'process raft request' (duration: 146.060887ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:00.231066Z","caller":"traceutil/trace.go:171","msg":"trace[1605299579] transaction","detail":"{read_only:false; response_revision:873; number_of_response:1; }","duration":"148.709229ms","start":"2026-07-01T09:30:00.082346Z","end":"2026-07-01T09:30:00.231055Z","steps":["trace[1605299579] 'process raft request' (duration: 73.005613ms)","trace[1605299579] 'compare' (duration: 75.11313ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:00.231127Z","caller":"traceutil/trace.go:171","msg":"trace[1399190273] linearizableReadLoop","detail":"{readStateIndex:908; appliedIndex:907; }","duration":"148.044871ms","start":"2026-07-01T09:30:00.083052Z","end":"2026-07-01T09:30:00.231097Z","steps":["trace[1399190273] 'read index received' (duration: 71.696788ms)","trace[1399190273] 'applied index is now lower than readState.Index' (duration: 76.346323ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:00.231313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.238477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-01T09:30:00.231348Z","caller":"traceutil/trace.go:171","msg":"trace[2144186412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:874; }","duration":"148.302478ms","start":"2026-07-01T09:30:00.083033Z","end":"2026-07-01T09:30:00.231336Z","steps":["trace[2144186412] 'agreement among raft nodes before linearized reading' (duration: 148.153384ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:00.957941Z","caller":"traceutil/trace.go:171","msg":"trace[732594194] linearizableReadLoop","detail":"{readStateIndex:913; appliedIndex:912; }","duration":"131.443128ms","start":"2026-07-01T09:30:00.826458Z","end":"2026-07-01T09:30:00.957901Z","steps":["trace[732594194] 'read index received' (duration: 128.804996ms)","trace[732594194] 'applied index is now lower than readState.Index' (duration: 2.637212ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:00.958235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.724646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T09:30:00.958335Z","caller":"traceutil/trace.go:171","msg":"trace[1004285187] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:878; }","duration":"131.90224ms","start":"2026-07-01T09:30:00.826421Z","end":"2026-07-01T09:30:00.958323Z","steps":["trace[1004285187] 'agreement among raft nodes before linearized reading' (duration: 131.654234ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:00.958616Z","caller":"traceutil/trace.go:171","msg":"trace[254545270] transaction","detail":"{read_only:false; response_revision:878; number_of_response:1; }","duration":"178.958645ms","start":"2026-07-01T09:30:00.779625Z","end":"2026-07-01T09:30:00.958583Z","steps":["trace[254545270] 'process raft request' (duration: 175.621524ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:01.832219Z","caller":"traceutil/trace.go:171","msg":"trace[1722955077] linearizableReadLoop","detail":"{readStateIndex:915; appliedIndex:914; }","duration":"113.739205ms","start":"2026-07-01T09:30:01.718451Z","end":"2026-07-01T09:30:01.83219Z","steps":["trace[1722955077] 'read index received' (duration: 113.540899ms)","trace[1722955077] 'applied index is now lower than readState.Index' (duration: 197.196µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:01.832282Z","caller":"traceutil/trace.go:171","msg":"trace[2083813724] transaction","detail":"{read_only:false; response_revision:880; number_of_response:1; }","duration":"288.645849ms","start":"2026-07-01T09:30:01.543604Z","end":"2026-07-01T09:30:01.83225Z","steps":["trace[2083813724] 'process raft request' (duration: 288.370102ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:01.832474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.95351ms","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-07-01T09:30:01.832551Z","caller":"traceutil/trace.go:171","msg":"trace[67912221] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:880; }","duration":"114.137536ms","start":"2026-07-01T09:30:01.718395Z","end":"2026-07-01T09:30:01.832533Z","steps":["trace[67912221] 'agreement among raft nodes before linearized reading' (duration: 113.943791ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:02.168449Z","caller":"traceutil/trace.go:171","msg":"trace[409113909] transaction","detail":"{read_only:false; response_revision:887; number_of_response:1; }","duration":"207.377561ms","start":"2026-07-01T09:30:01.961042Z","end":"2026-07-01T09:30:02.16842Z","steps":["trace[409113909] 'process raft request' (duration: 178.826792ms)","trace[409113909] 'compare' (duration: 28.269732ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:04.411681Z","caller":"traceutil/trace.go:171","msg":"trace[1409813193] transaction","detail":"{read_only:false; response_revision:926; number_of_response:1; }","duration":"142.044357ms","start":"2026-07-01T09:30:04.269602Z","end":"2026-07-01T09:30:04.411647Z","steps":["trace[1409813193] 'process raft request' (duration: 141.825851ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:04.552706Z","caller":"traceutil/trace.go:171","msg":"trace[17729971] linearizableReadLoop","detail":"{readStateIndex:962; appliedIndex:960; }","duration":"222.022141ms","start":"2026-07-01T09:30:04.330663Z","end":"2026-07-01T09:30:04.552686Z","steps":["trace[17729971] 'read index received' (duration: 80.730264ms)","trace[17729971] 'applied index is now lower than readState.Index' (duration: 141.291077ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:04.552812Z","caller":"traceutil/trace.go:171","msg":"trace[44316315] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"282.873011ms","start":"2026-07-01T09:30:04.269895Z","end":"2026-07-01T09:30:04.552768Z","steps":["trace[44316315] 'process raft request' (duration: 222.988536ms)","trace[44316315] 'compare' (duration: 59.718001ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:04.553935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.250984ms","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-07-01T09:30:04.553992Z","caller":"traceutil/trace.go:171","msg":"trace[157649021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:927; }","duration":"223.361307ms","start":"2026-07-01T09:30:04.330618Z","end":"2026-07-01T09:30:04.553979Z","steps":["trace[157649021] 'agreement among raft nodes before linearized reading' (duration: 222.153034ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:18.951715Z","caller":"traceutil/trace.go:171","msg":"trace[1051964872] transaction","detail":"{read_only:false; response_revision:983; number_of_response:1; }","duration":"213.595441ms","start":"2026-07-01T09:30:18.738088Z","end":"2026-07-01T09:30:18.951684Z","steps":["trace[1051964872] 'process raft request' (duration: 143.792185ms)","trace[1051964872] 'compare' (duration: 69.58207ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:31.214009Z","caller":"traceutil/trace.go:171","msg":"trace[1333005622] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1066; }","duration":"422.909914ms","start":"2026-07-01T09:30:30.791062Z","end":"2026-07-01T09:30:31.213972Z","steps":["trace[1333005622] 'read index received' (duration: 422.716129ms)","trace[1333005622] 'applied index is now lower than readState.Index' (duration: 192.165µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:31.214059Z","caller":"traceutil/trace.go:171","msg":"trace[2107569122] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"602.280061ms","start":"2026-07-01T09:30:30.611748Z","end":"2026-07-01T09:30:31.214028Z","steps":["trace[2107569122] 'process raft request' (duration: 602.031704ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:31.214225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:30.611733Z","time spent":"602.401304ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:30:31.214323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.176049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-01T09:30:31.21435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.258004ms","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-07-01T09:30:31.21447Z","caller":"traceutil/trace.go:171","msg":"trace[1051109336] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1026; }","duration":"423.417688ms","start":"2026-07-01T09:30:30.79103Z","end":"2026-07-01T09:30:31.214448Z","steps":["trace[1051109336] 'agreement among raft nodes before linearized reading' (duration: 423.100729ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:31.214391Z","caller":"traceutil/trace.go:171","msg":"trace[779755023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1026; }","duration":"154.294292ms","start":"2026-07-01T09:30:31.060078Z","end":"2026-07-01T09:30:31.214372Z","steps":["trace[779755023] 'agreement among raft nodes before linearized reading' (duration: 154.078196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:31.21457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:30.791014Z","time spent":"423.544501ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T09:30:31.32247Z","caller":"traceutil/trace.go:171","msg":"trace[1041886823] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"103.741302ms","start":"2026-07-01T09:30:31.218709Z","end":"2026-07-01T09:30:31.32245Z","steps":["trace[1041886823] 'process raft request' (duration: 103.679281ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:31.322676Z","caller":"traceutil/trace.go:171","msg":"trace[435645578] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"103.170106ms","start":"2026-07-01T09:30:31.21949Z","end":"2026-07-01T09:30:31.32266Z","steps":["trace[435645578] 'process raft request' (duration: 102.93127ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:31.323069Z","caller":"traceutil/trace.go:171","msg":"trace[1245270308] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"104.272537ms","start":"2026-07-01T09:30:31.218335Z","end":"2026-07-01T09:30:31.322607Z","steps":["trace[1245270308] 'process raft request' (duration: 48.246647ms)","trace[1245270308] 'compare' (duration: 55.692371ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:32.231714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.291551ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:30:32.23197Z","caller":"traceutil/trace.go:171","msg":"trace[872014039] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1070; }","duration":"904.157131ms","start":"2026-07-01T09:30:31.3278Z","end":"2026-07-01T09:30:32.231957Z","steps":["trace[872014039] 'read index received' (duration: 479.568502ms)","trace[872014039] 'applied index is now lower than readState.Index' (duration: 424.587669ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:32.23204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.238473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:30:32.232066Z","caller":"traceutil/trace.go:171","msg":"trace[2144762226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1030; }","duration":"904.298785ms","start":"2026-07-01T09:30:31.32776Z","end":"2026-07-01T09:30:32.232058Z","steps":["trace[2144762226] 'agreement among raft nodes before linearized reading' (duration: 904.230293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:32.232093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:31.327748Z","time spent":"904.338825ms","remote":"127.0.0.1:58462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T09:30:32.232254Z","caller":"traceutil/trace.go:171","msg":"trace[1030964113] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"905.024534ms","start":"2026-07-01T09:30:31.327196Z","end":"2026-07-01T09:30:32.232221Z","steps":["trace[1030964113] 'process raft request' (duration: 480.159027ms)","trace[1030964113] 'compare' (duration: 424.209499ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:32.232377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:31.327174Z","time spent":"905.137928ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:30:32.860287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.806941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:30:32.860503Z","caller":"traceutil/trace.go:171","msg":"trace[243233969] linearizableReadLoop","detail":"{readStateIndex:1073; appliedIndex:1071; }","duration":"532.516277ms","start":"2026-07-01T09:30:32.327971Z","end":"2026-07-01T09:30:32.860488Z","steps":["trace[243233969] 'read index received' (duration: 249.47926ms)","trace[243233969] 'applied index is now lower than readState.Index' (duration: 283.036187ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:32.860591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.618709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:30:32.860624Z","caller":"traceutil/trace.go:171","msg":"trace[2039287413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1032; }","duration":"532.681311ms","start":"2026-07-01T09:30:32.327933Z","end":"2026-07-01T09:30:32.860614Z","steps":["trace[2039287413] 'agreement among raft nodes before linearized reading' (duration: 532.607929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:32.860655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:32.327915Z","time spent":"532.732513ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-01T09:30:32.860659Z","caller":"traceutil/trace.go:171","msg":"trace[1645822625] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"1.513674509s","start":"2026-07-01T09:30:31.346946Z","end":"2026-07-01T09:30:32.860621Z","steps":["trace[1645822625] 'process raft request' (duration: 1.230446808s)","trace[1645822625] 'compare' (duration: 282.407429ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:32.860843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:31.346928Z","time spent":"1.513823583s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:30:32.86066Z","caller":"traceutil/trace.go:171","msg":"trace[87299202] transaction","detail":"{read_only:false; response_revision:1032; number_of_response:1; }","duration":"1.291178125s","start":"2026-07-01T09:30:31.569445Z","end":"2026-07-01T09:30:32.860623Z","steps":["trace[87299202] 'process raft request' (duration: 1.290939339s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:32.861012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:31.569422Z","time spent":"1.291505835s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:30:36.371687Z","caller":"traceutil/trace.go:171","msg":"trace[1527210473] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"123.828361ms","start":"2026-07-01T09:30:36.24784Z","end":"2026-07-01T09:30:36.371669Z","steps":["trace[1527210473] 'process raft request' (duration: 123.723168ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:38.508601Z","caller":"traceutil/trace.go:171","msg":"trace[981016514] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"129.536147ms","start":"2026-07-01T09:30:38.378866Z","end":"2026-07-01T09:30:38.508402Z","steps":["trace[981016514] 'process raft request' (duration: 129.402143ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:39.544566Z","caller":"traceutil/trace.go:171","msg":"trace[496396813] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"111.187056ms","start":"2026-07-01T09:30:39.433352Z","end":"2026-07-01T09:30:39.544539Z","steps":["trace[496396813] 'process raft request' (duration: 50.422417ms)","trace[496396813] 'compare' (duration: 60.610894ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:39.544757Z","caller":"traceutil/trace.go:171","msg":"trace[892323097] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"110.401494ms","start":"2026-07-01T09:30:39.434329Z","end":"2026-07-01T09:30:39.54473Z","steps":["trace[892323097] 'process raft request' (duration: 110.171798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:55.5664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.893339ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-01T09:30:55.566911Z","caller":"traceutil/trace.go:171","msg":"trace[466741034] linearizableReadLoop","detail":"{readStateIndex:1151; appliedIndex:1148; }","duration":"241.385949ms","start":"2026-07-01T09:30:55.325506Z","end":"2026-07-01T09:30:55.566892Z","steps":["trace[466741034] 'read index received' (duration: 53.001297ms)","trace[466741034] 'applied index is now lower than readState.Index' (duration: 188.383112ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:55.566978Z","caller":"traceutil/trace.go:171","msg":"trace[1402428032] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"598.212229ms","start":"2026-07-01T09:30:54.968727Z","end":"2026-07-01T09:30:55.566939Z","steps":["trace[1402428032] 'process raft request' (duration: 597.788708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:55.567078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.563304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:30:55.567149Z","caller":"traceutil/trace.go:171","msg":"trace[1200076698] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1105; }","duration":"241.676027ms","start":"2026-07-01T09:30:55.325462Z","end":"2026-07-01T09:30:55.567138Z","steps":["trace[1200076698] 'agreement among raft nodes before linearized reading' (duration: 241.541543ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:55.567158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:54.968704Z","time spent":"598.357664ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:30:55.567218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.715125ms","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-07-01T09:30:55.567315Z","caller":"traceutil/trace.go:171","msg":"trace[1108975669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1105; }","duration":"231.868979ms","start":"2026-07-01T09:30:55.33543Z","end":"2026-07-01T09:30:55.567299Z","steps":["trace[1108975669] 'agreement among raft nodes before linearized reading' (duration: 231.631833ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:55.567488Z","caller":"traceutil/trace.go:171","msg":"trace[802416229] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"558.28427ms","start":"2026-07-01T09:30:55.008712Z","end":"2026-07-01T09:30:55.566997Z","steps":["trace[802416229] 'process raft request' (duration: 558.078934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:55.567589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:55.008692Z","time spent":"558.832244ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:30:55.932451Z","caller":"traceutil/trace.go:171","msg":"trace[1059380853] linearizableReadLoop","detail":"{readStateIndex:1153; appliedIndex:1151; }","duration":"323.949013ms","start":"2026-07-01T09:30:55.60843Z","end":"2026-07-01T09:30:55.932379Z","steps":["trace[1059380853] 'read index received' (duration: 27.412608ms)","trace[1059380853] 'applied index is now lower than readState.Index' (duration: 296.535125ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:30:55.932587Z","caller":"traceutil/trace.go:171","msg":"trace[1095490806] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"359.097902ms","start":"2026-07-01T09:30:55.573467Z","end":"2026-07-01T09:30:55.932565Z","steps":["trace[1095490806] 'process raft request' (duration: 343.947779ms)","trace[1095490806] 'compare' (duration: 14.511686ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:30:55.932706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:55.573443Z","time spent":"359.178695ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:30:55.93289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.463505ms","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-07-01T09:30:55.932944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.490878ms","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-07-01T09:30:55.933075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.665414ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T09:30:55.933135Z","caller":"traceutil/trace.go:171","msg":"trace[712210382] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1107; }","duration":"324.730534ms","start":"2026-07-01T09:30:55.608383Z","end":"2026-07-01T09:30:55.933113Z","steps":["trace[712210382] 'agreement among raft nodes before linearized reading' (duration: 324.303573ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:55.933151Z","caller":"traceutil/trace.go:171","msg":"trace[408107356] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1107; }","duration":"305.834929ms","start":"2026-07-01T09:30:55.627299Z","end":"2026-07-01T09:30:55.933134Z","steps":["trace[408107356] 'agreement among raft nodes before linearized reading' (duration: 305.676855ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:55.933004Z","caller":"traceutil/trace.go:171","msg":"trace[1226064551] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1107; }","duration":"321.62778ms","start":"2026-07-01T09:30:55.611356Z","end":"2026-07-01T09:30:55.932983Z","steps":["trace[1226064551] 'agreement among raft nodes before linearized reading' (duration: 321.27744ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:30:55.933219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:55.627274Z","time spent":"305.935501ms","remote":"127.0.0.1:58640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":11,"response size":30,"request content":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:30:55.933254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:55.611337Z","time spent":"321.902788ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T09:30:55.933284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:30:55.608367Z","time spent":"324.838858ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T09:30:57.470908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.126681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:30:57.471012Z","caller":"traceutil/trace.go:171","msg":"trace[91490767] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1110; }","duration":"145.498852ms","start":"2026-07-01T09:30:57.325495Z","end":"2026-07-01T09:30:57.470994Z","steps":["trace[91490767] 'range keys from in-memory index tree' (duration: 145.024329ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:30:57.717385Z","caller":"traceutil/trace.go:171","msg":"trace[2105523900] transaction","detail":"{read_only:false; response_revision:1111; number_of_response:1; }","duration":"143.445676ms","start":"2026-07-01T09:30:57.573902Z","end":"2026-07-01T09:30:57.717348Z","steps":["trace[2105523900] 'process raft request' (duration: 143.25208ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:17.824585Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605637715450498,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T09:31:17.970811Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.062835506s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T09:31:17.971181Z","caller":"traceutil/trace.go:171","msg":"trace[93054268] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"1.063284699s","start":"2026-07-01T09:31:16.907869Z","end":"2026-07-01T09:31:17.971154Z","steps":["trace[93054268] 'process raft request' (duration: 1.063123334s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:17.971343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:16.907851Z","time spent":"1.063409752s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:31:18.699403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.626327ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:31:18.699479Z","caller":"traceutil/trace.go:171","msg":"trace[1808168717] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1278; }","duration":"1.375168704s","start":"2026-07-01T09:31:17.324299Z","end":"2026-07-01T09:31:18.699467Z","steps":["trace[1808168717] 'read index received' (duration: 646.672048ms)","trace[1808168717] 'applied index is now lower than readState.Index' (duration: 728.495536ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:18.699539Z","caller":"traceutil/trace.go:171","msg":"trace[619153576] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"899.994369ms","start":"2026-07-01T09:31:17.799537Z","end":"2026-07-01T09:31:18.699531Z","steps":["trace[619153576] 'process raft request' (duration: 754.165976ms)","trace[619153576] 'compare' (duration: 145.517354ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:31:18.699581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:17.799512Z","time spent":"900.04411ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:31:18.699733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.375444742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:31:18.700347Z","caller":"traceutil/trace.go:171","msg":"trace[1325817730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1228; }","duration":"1.375506194s","start":"2026-07-01T09:31:17.324246Z","end":"2026-07-01T09:31:18.699752Z","steps":["trace[1325817730] 'agreement among raft nodes before linearized reading' (duration: 1.375465102s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:18.700328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"859.70305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:31:18.700397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:17.324225Z","time spent":"1.376160261s","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T09:31:18.700392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.115176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T09:31:18.70041Z","caller":"traceutil/trace.go:171","msg":"trace[1237610622] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1228; }","duration":"859.843285ms","start":"2026-07-01T09:31:17.840549Z","end":"2026-07-01T09:31:18.700392Z","steps":["trace[1237610622] 'agreement among raft nodes before linearized reading' (duration: 859.702161ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:18.700446Z","caller":"traceutil/trace.go:171","msg":"trace[2129743976] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1228; }","duration":"804.217749ms","start":"2026-07-01T09:31:17.896215Z","end":"2026-07-01T09:31:18.700433Z","steps":["trace[2129743976] 'agreement among raft nodes before linearized reading' (duration: 804.124477ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:18.700456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.530029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-01T09:31:18.700467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:17.840524Z","time spent":"859.932257ms","remote":"127.0.0.1:58584","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:31:18.700483Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:17.896198Z","time spent":"804.277851ms","remote":"127.0.0.1:56022","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"info","ts":"2026-07-01T09:31:18.700491Z","caller":"traceutil/trace.go:171","msg":"trace[976401382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1228; }","duration":"597.562549ms","start":"2026-07-01T09:31:18.102918Z","end":"2026-07-01T09:31:18.700481Z","steps":["trace[976401382] 'agreement among raft nodes before linearized reading' (duration: 597.472607ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:18.700519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:18.102878Z","time spent":"597.633941ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T09:31:18.700527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.05507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-01T09:31:18.700571Z","caller":"traceutil/trace.go:171","msg":"trace[2059852090] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1228; }","duration":"624.126473ms","start":"2026-07-01T09:31:18.076431Z","end":"2026-07-01T09:31:18.700557Z","steps":["trace[2059852090] 'agreement among raft nodes before linearized reading' (duration: 623.973558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:18.700357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.744006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-01T09:31:18.700607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:18.076414Z","time spent":"624.185985ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-01T09:31:18.700614Z","caller":"traceutil/trace.go:171","msg":"trace[1423161202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1228; }","duration":"641.035754ms","start":"2026-07-01T09:31:18.059567Z","end":"2026-07-01T09:31:18.700603Z","steps":["trace[1423161202] 'agreement among raft nodes before linearized reading' (duration: 640.682864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:18.70064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:18.05955Z","time spent":"641.082045ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T09:31:18.70072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.63385ms","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-07-01T09:31:18.70085Z","caller":"traceutil/trace.go:171","msg":"trace[1541032852] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1228; }","duration":"797.760003ms","start":"2026-07-01T09:31:17.903048Z","end":"2026-07-01T09:31:18.700808Z","steps":["trace[1541032852] 'agreement among raft nodes before linearized reading' (duration: 797.223949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:18.70095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:17.903033Z","time spent":"797.903828ms","remote":"127.0.0.1:58738","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-07-01T09:31:28.917651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.733152ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:31:28.917875Z","caller":"traceutil/trace.go:171","msg":"trace[1367331112] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"139.428859ms","start":"2026-07-01T09:31:28.778429Z","end":"2026-07-01T09:31:28.917858Z","steps":["trace[1367331112] 'process raft request' (duration: 139.395948ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:28.917993Z","caller":"traceutil/trace.go:171","msg":"trace[1385750548] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"140.791796ms","start":"2026-07-01T09:31:28.777182Z","end":"2026-07-01T09:31:28.917974Z","steps":["trace[1385750548] 'process raft request' (duration: 27.661093ms)","trace[1385750548] 'compare' (duration: 112.609499ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:28.91809Z","caller":"traceutil/trace.go:171","msg":"trace[1955185804] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"140.294553ms","start":"2026-07-01T09:31:28.777762Z","end":"2026-07-01T09:31:28.918056Z","steps":["trace[1955185804] 'process raft request' (duration: 139.985285ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:28.918177Z","caller":"traceutil/trace.go:171","msg":"trace[2055788483] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"140.21365ms","start":"2026-07-01T09:31:28.777956Z","end":"2026-07-01T09:31:28.918169Z","steps":["trace[2055788483] 'process raft request' (duration: 139.83988ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:31.258751Z","caller":"traceutil/trace.go:171","msg":"trace[260422343] linearizableReadLoop","detail":"{readStateIndex:1323; appliedIndex:1322; }","duration":"337.591388ms","start":"2026-07-01T09:31:30.921133Z","end":"2026-07-01T09:31:31.258724Z","steps":["trace[260422343] 'read index received' (duration: 337.361941ms)","trace[260422343] 'applied index is now lower than readState.Index' (duration: 228.307µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:31.25891Z","caller":"traceutil/trace.go:171","msg":"trace[1282593028] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"479.75315ms","start":"2026-07-01T09:31:30.779142Z","end":"2026-07-01T09:31:31.258895Z","steps":["trace[1282593028] 'process raft request' (duration: 479.420421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:31.259022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:30.779119Z","time spent":"479.820683ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:31:31.259168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.989981ms","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-07-01T09:31:31.259243Z","caller":"traceutil/trace.go:171","msg":"trace[1079217757] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1268; }","duration":"337.081023ms","start":"2026-07-01T09:31:30.92214Z","end":"2026-07-01T09:31:31.259221Z","steps":["trace[1079217757] 'agreement among raft nodes before linearized reading' (duration: 336.875708ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:31.259288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:30.922135Z","time spent":"337.142705ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T09:31:31.259472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.846997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-07-01T09:31:31.25947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.18874ms","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-07-01T09:31:31.259506Z","caller":"traceutil/trace.go:171","msg":"trace[1628707029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1268; }","duration":"336.9363ms","start":"2026-07-01T09:31:30.92256Z","end":"2026-07-01T09:31:31.259496Z","steps":["trace[1628707029] 'agreement among raft nodes before linearized reading' (duration: 336.834587ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:31.25952Z","caller":"traceutil/trace.go:171","msg":"trace[887117802] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1268; }","duration":"336.249081ms","start":"2026-07-01T09:31:30.923258Z","end":"2026-07-01T09:31:31.259507Z","steps":["trace[887117802] 'agreement among raft nodes before linearized reading' (duration: 336.089637ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:31.25954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:30.922491Z","time spent":"337.040003ms","remote":"127.0.0.1:58738","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-07-01T09:31:31.259564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:30.923251Z","time spent":"336.303722ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T09:31:31.259707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.571534ms","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-07-01T09:31:31.259733Z","caller":"traceutil/trace.go:171","msg":"trace[625187504] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1268; }","duration":"338.620295ms","start":"2026-07-01T09:31:30.921104Z","end":"2026-07-01T09:31:31.259725Z","steps":["trace[625187504] 'agreement among raft nodes before linearized reading' (duration: 338.542813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:31.25976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:30.921089Z","time spent":"338.662987ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-01T09:31:31.388982Z","caller":"traceutil/trace.go:171","msg":"trace[436351737] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"123.386092ms","start":"2026-07-01T09:31:31.265565Z","end":"2026-07-01T09:31:31.388951Z","steps":["trace[436351737] 'process raft request' (duration: 123.31848ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:31.389139Z","caller":"traceutil/trace.go:171","msg":"trace[1635289264] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"124.436251ms","start":"2026-07-01T09:31:31.264694Z","end":"2026-07-01T09:31:31.38913Z","steps":["trace[1635289264] 'process raft request' (duration: 124.100881ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:31.389278Z","caller":"traceutil/trace.go:171","msg":"trace[441105539] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"123.68524ms","start":"2026-07-01T09:31:31.265571Z","end":"2026-07-01T09:31:31.389257Z","steps":["trace[441105539] 'process raft request' (duration: 123.347591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:35.826377Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605637715450638,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T09:31:36.389459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.070399491s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-01T09:31:36.390169Z","caller":"traceutil/trace.go:171","msg":"trace[1071467273] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1343; }","duration":"1.064207232s","start":"2026-07-01T09:31:35.325933Z","end":"2026-07-01T09:31:36.39014Z","steps":["trace[1071467273] 'read index received' (duration: 748.996856ms)","trace[1071467273] 'applied index is now lower than readState.Index' (duration: 315.209166ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:36.390238Z","caller":"traceutil/trace.go:171","msg":"trace[1462958635] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"1.100535292s","start":"2026-07-01T09:31:35.289664Z","end":"2026-07-01T09:31:36.390199Z","steps":["trace[1462958635] 'process raft request' (duration: 1.099886294s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:36.390437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.289633Z","time spent":"1.100707357s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:31:36.516194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.190234716s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:31:36.516289Z","caller":"traceutil/trace.go:171","msg":"trace[305101787] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1289; }","duration":"1.19037541s","start":"2026-07-01T09:31:35.32589Z","end":"2026-07-01T09:31:36.516265Z","steps":["trace[305101787] 'agreement among raft nodes before linearized reading' (duration: 1.064346326s)","trace[305101787] 'range keys from in-memory index tree' (duration: 125.90115ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:31:36.516362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.325866Z","time spent":"1.190486043s","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T09:31:36.516631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.286755ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:31:36.516739Z","caller":"traceutil/trace.go:171","msg":"trace[1802543961] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1345; }","duration":"126.511487ms","start":"2026-07-01T09:31:36.390213Z","end":"2026-07-01T09:31:36.516724Z","steps":["trace[1802543961] 'read index received' (duration: 19.721568ms)","trace[1802543961] 'applied index is now lower than readState.Index' (duration: 106.788469ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:31:36.516809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11991159s","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-07-01T09:31:36.516842Z","caller":"traceutil/trace.go:171","msg":"trace[346425264] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1290; }","duration":"1.119972142s","start":"2026-07-01T09:31:35.396861Z","end":"2026-07-01T09:31:36.516833Z","steps":["trace[346425264] 'agreement among raft nodes before linearized reading' (duration: 1.1199125s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:36.516879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.396846Z","time spent":"1.120025023s","remote":"127.0.0.1:44372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-07-01T09:31:36.516944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.473121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-01T09:31:36.516944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.015933268s","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-07-01T09:31:36.51699Z","caller":"traceutil/trace.go:171","msg":"trace[2066120962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1290; }","duration":"280.558863ms","start":"2026-07-01T09:31:36.236419Z","end":"2026-07-01T09:31:36.516978Z","steps":["trace[2066120962] 'agreement among raft nodes before linearized reading' (duration: 280.406669ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:36.517013Z","caller":"traceutil/trace.go:171","msg":"trace[74663993] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1290; }","duration":"1.01604177s","start":"2026-07-01T09:31:35.500954Z","end":"2026-07-01T09:31:36.516996Z","steps":["trace[74663993] 'agreement among raft nodes before linearized reading' (duration: 1.015846635s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:36.517025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.214651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-01T09:31:36.517072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.500933Z","time spent":"1.016126972s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-01T09:31:36.517073Z","caller":"traceutil/trace.go:171","msg":"trace[1903627938] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1290; }","duration":"564.303543ms","start":"2026-07-01T09:31:35.952757Z","end":"2026-07-01T09:31:36.517061Z","steps":["trace[1903627938] 'agreement among raft nodes before linearized reading' (duration: 564.215861ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:36.517121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.952735Z","time spent":"564.376665ms","remote":"127.0.0.1:58556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":17,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"info","ts":"2026-07-01T09:31:36.517151Z","caller":"traceutil/trace.go:171","msg":"trace[850665115] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"142.902233ms","start":"2026-07-01T09:31:36.374227Z","end":"2026-07-01T09:31:36.517129Z","steps":["trace[850665115] 'process raft request' (duration: 35.771945ms)","trace[850665115] 'compare' (duration: 106.039058ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:31:36.517239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.102799074s","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-07-01T09:31:36.517282Z","caller":"traceutil/trace.go:171","msg":"trace[2122595643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1290; }","duration":"1.102862726s","start":"2026-07-01T09:31:35.414409Z","end":"2026-07-01T09:31:36.517272Z","steps":["trace[2122595643] 'agreement among raft nodes before linearized reading' (duration: 1.102764313s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:36.517317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.414398Z","time spent":"1.102913287s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T09:31:36.517286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.102807274s","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-07-01T09:31:36.517468Z","caller":"traceutil/trace.go:171","msg":"trace[1345135537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1290; }","duration":"1.10299954s","start":"2026-07-01T09:31:35.414457Z","end":"2026-07-01T09:31:36.517456Z","steps":["trace[1345135537] 'agreement among raft nodes before linearized reading' (duration: 1.102780394s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:36.517514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.414452Z","time spent":"1.103050821s","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-01T09:31:36.517651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.102052823s","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-07-01T09:31:36.517718Z","caller":"traceutil/trace.go:171","msg":"trace[754576394] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1290; }","duration":"1.102670111s","start":"2026-07-01T09:31:35.415038Z","end":"2026-07-01T09:31:36.517708Z","steps":["trace[754576394] 'agreement among raft nodes before linearized reading' (duration: 1.102016073s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:36.518346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:35.415028Z","time spent":"1.103302228s","remote":"127.0.0.1:58738","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-07-01T09:31:37.038457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.946414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:31:37.038824Z","caller":"traceutil/trace.go:171","msg":"trace[1643200899] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"517.214321ms","start":"2026-07-01T09:31:36.521557Z","end":"2026-07-01T09:31:37.038771Z","steps":["trace[1643200899] 'process raft request' (duration: 137.869486ms)","trace[1643200899] 'compare' (duration: 378.674067ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:37.038902Z","caller":"traceutil/trace.go:171","msg":"trace[494358712] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"516.339648ms","start":"2026-07-01T09:31:36.522549Z","end":"2026-07-01T09:31:37.038889Z","steps":["trace[494358712] 'process raft request' (duration: 516.112071ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:37.039442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:36.522509Z","time spent":"516.884042ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:31:37.038945Z","caller":"traceutil/trace.go:171","msg":"trace[12603655] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"516.222915ms","start":"2026-07-01T09:31:36.522714Z","end":"2026-07-01T09:31:37.038937Z","steps":["trace[12603655] 'process raft request' (duration: 516.121802ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:37.03966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:36.522681Z","time spent":"516.952055ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:31:37.038978Z","caller":"traceutil/trace.go:171","msg":"trace[1017668806] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"516.300267ms","start":"2026-07-01T09:31:36.52267Z","end":"2026-07-01T09:31:37.03897Z","steps":["trace[1017668806] 'process raft request' (duration: 516.111652ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:37.039841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:36.522656Z","time spent":"517.15344ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:31:37.038978Z","caller":"traceutil/trace.go:171","msg":"trace[1469437156] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"235.676711ms","start":"2026-07-01T09:31:36.803276Z","end":"2026-07-01T09:31:37.038952Z","steps":["trace[1469437156] 'process raft request' (duration: 235.6256ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:37.039031Z","caller":"traceutil/trace.go:171","msg":"trace[1663388414] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"516.208044ms","start":"2026-07-01T09:31:36.522813Z","end":"2026-07-01T09:31:37.039021Z","steps":["trace[1663388414] 'process raft request' (duration: 516.05135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:37.040297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:36.522804Z","time spent":"517.459378ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:31:37.039074Z","caller":"traceutil/trace.go:171","msg":"trace[1917892353] linearizableReadLoop","detail":"{readStateIndex:1351; appliedIndex:1346; }","duration":"512.066382ms","start":"2026-07-01T09:31:36.526982Z","end":"2026-07-01T09:31:37.039049Z","steps":["trace[1917892353] 'read index received' (duration: 132.409918ms)","trace[1917892353] 'applied index is now lower than readState.Index' (duration: 379.654514ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:31:37.039173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"512.179425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T09:31:37.040453Z","caller":"traceutil/trace.go:171","msg":"trace[1160855050] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1296; }","duration":"513.515091ms","start":"2026-07-01T09:31:36.526925Z","end":"2026-07-01T09:31:37.04044Z","steps":["trace[1160855050] 'agreement among raft nodes before linearized reading' (duration: 512.200135ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:37.040591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:36.526909Z","time spent":"513.574563ms","remote":"127.0.0.1:58458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T09:31:37.041154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:36.521537Z","time spent":"517.745666ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:31:39.283062Z","caller":"traceutil/trace.go:171","msg":"trace[151401156] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"238.976691ms","start":"2026-07-01T09:31:39.044059Z","end":"2026-07-01T09:31:39.283036Z","steps":["trace[151401156] 'read index received' (duration: 238.818607ms)","trace[151401156] 'applied index is now lower than readState.Index' (duration: 156.974µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:39.283138Z","caller":"traceutil/trace.go:171","msg":"trace[1929779878] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"887.389996ms","start":"2026-07-01T09:31:38.395717Z","end":"2026-07-01T09:31:39.283107Z","steps":["trace[1929779878] 'process raft request' (duration: 887.15536ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:39.283246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:38.395694Z","time spent":"887.496339ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:31:39.283305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.221108ms","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-07-01T09:31:39.28338Z","caller":"traceutil/trace.go:171","msg":"trace[1026253443] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1297; }","duration":"239.346821ms","start":"2026-07-01T09:31:39.044019Z","end":"2026-07-01T09:31:39.283366Z","steps":["trace[1026253443] 'agreement among raft nodes before linearized reading' (duration: 239.164366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:39.283392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.94197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-01T09:31:39.283434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.983711ms","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-07-01T09:31:39.283471Z","caller":"traceutil/trace.go:171","msg":"trace[2020961620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1297; }","duration":"239.030043ms","start":"2026-07-01T09:31:39.044432Z","end":"2026-07-01T09:31:39.283462Z","steps":["trace[2020961620] 'agreement among raft nodes before linearized reading' (duration: 238.94616ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:39.283481Z","caller":"traceutil/trace.go:171","msg":"trace[1230662409] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1297; }","duration":"239.063554ms","start":"2026-07-01T09:31:39.044391Z","end":"2026-07-01T09:31:39.283454Z","steps":["trace[1230662409] 'agreement among raft nodes before linearized reading' (duration: 238.831607ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:39.283537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.444717ms","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-07-01T09:31:39.283588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.395715ms","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-07-01T09:31:39.283677Z","caller":"traceutil/trace.go:171","msg":"trace[1571119826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1297; }","duration":"238.520808ms","start":"2026-07-01T09:31:39.045138Z","end":"2026-07-01T09:31:39.283659Z","steps":["trace[1571119826] 'agreement among raft nodes before linearized reading' (duration: 238.259021ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:39.283619Z","caller":"traceutil/trace.go:171","msg":"trace[925744796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1297; }","duration":"238.55683ms","start":"2026-07-01T09:31:39.045044Z","end":"2026-07-01T09:31:39.283601Z","steps":["trace[925744796] 'agreement among raft nodes before linearized reading' (duration: 238.260801ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:39.45174Z","caller":"traceutil/trace.go:171","msg":"trace[1473037148] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"162.523448ms","start":"2026-07-01T09:31:39.289191Z","end":"2026-07-01T09:31:39.451715Z","steps":["trace[1473037148] 'process raft request' (duration: 162.474756ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:39.451931Z","caller":"traceutil/trace.go:171","msg":"trace[1399064084] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"163.259998ms","start":"2026-07-01T09:31:39.288656Z","end":"2026-07-01T09:31:39.451916Z","steps":["trace[1399064084] 'process raft request' (duration: 108.26919ms)","trace[1399064084] 'compare' (duration: 54.427693ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:39.451939Z","caller":"traceutil/trace.go:171","msg":"trace[1617632576] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"163.222406ms","start":"2026-07-01T09:31:39.288707Z","end":"2026-07-01T09:31:39.45193Z","steps":["trace[1617632576] 'process raft request' (duration: 162.865147ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:39.451965Z","caller":"traceutil/trace.go:171","msg":"trace[1806705452] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"163.084673ms","start":"2026-07-01T09:31:39.288876Z","end":"2026-07-01T09:31:39.451961Z","steps":["trace[1806705452] 'process raft request' (duration: 162.754484ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:39.959429Z","caller":"traceutil/trace.go:171","msg":"trace[1530025216] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"127.022279ms","start":"2026-07-01T09:31:39.832383Z","end":"2026-07-01T09:31:39.959405Z","steps":["trace[1530025216] 'process raft request' (duration: 126.890036ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:40.273751Z","caller":"traceutil/trace.go:171","msg":"trace[442778998] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"136.574732ms","start":"2026-07-01T09:31:40.137151Z","end":"2026-07-01T09:31:40.273725Z","steps":["trace[442778998] 'process raft request' (duration: 76.234558ms)","trace[442778998] 'compare' (duration: 60.153709ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:41.530628Z","caller":"traceutil/trace.go:171","msg":"trace[1614218525] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"630.925629ms","start":"2026-07-01T09:31:40.899678Z","end":"2026-07-01T09:31:41.530604Z","steps":["trace[1614218525] 'process raft request' (duration: 630.755354ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:41.530777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:40.899662Z","time spent":"631.036331ms","remote":"127.0.0.1:58638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5456,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T09:31:41.639133Z","caller":"traceutil/trace.go:171","msg":"trace[1150647587] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1363; }","duration":"298.896382ms","start":"2026-07-01T09:31:41.340211Z","end":"2026-07-01T09:31:41.639108Z","steps":["trace[1150647587] 'read index received' (duration: 190.198171ms)","trace[1150647587] 'applied index is now lower than readState.Index' (duration: 108.697311ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:41.639187Z","caller":"traceutil/trace.go:171","msg":"trace[408716161] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"350.386125ms","start":"2026-07-01T09:31:41.288761Z","end":"2026-07-01T09:31:41.639147Z","steps":["trace[408716161] 'process raft request' (duration: 289.660981ms)","trace[408716161] 'compare' (duration: 60.490808ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:31:41.639345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T09:31:41.288735Z","time spent":"350.526088ms","remote":"127.0.0.1:58738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T09:31:41.639374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.143698ms","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-07-01T09:31:41.639406Z","caller":"traceutil/trace.go:171","msg":"trace[482995231] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1308; }","duration":"299.229321ms","start":"2026-07-01T09:31:41.340168Z","end":"2026-07-01T09:31:41.639397Z","steps":["trace[482995231] 'agreement among raft nodes before linearized reading' (duration: 299.067986ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:41.639587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.437446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-01T09:31:41.639618Z","caller":"traceutil/trace.go:171","msg":"trace[916370817] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1308; }","duration":"183.468077ms","start":"2026-07-01T09:31:41.456143Z","end":"2026-07-01T09:31:41.639611Z","steps":["trace[916370817] 'agreement among raft nodes before linearized reading' (duration: 183.387184ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:41.639751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.412235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-07-01T09:31:41.639749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.528504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-07-01T09:31:41.639783Z","caller":"traceutil/trace.go:171","msg":"trace[1589513711] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1308; }","duration":"183.445776ms","start":"2026-07-01T09:31:41.45633Z","end":"2026-07-01T09:31:41.639775Z","steps":["trace[1589513711] 'agreement among raft nodes before linearized reading' (duration: 183.365384ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:41.639793Z","caller":"traceutil/trace.go:171","msg":"trace[1785677623] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:1308; }","duration":"105.571315ms","start":"2026-07-01T09:31:41.534211Z","end":"2026-07-01T09:31:41.639782Z","steps":["trace[1785677623] 'agreement among raft nodes before linearized reading' (duration: 105.468943ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:41.639933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.643564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T09:31:41.639971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.813956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-07-01T09:31:41.63999Z","caller":"traceutil/trace.go:171","msg":"trace[559613829] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"222.733637ms","start":"2026-07-01T09:31:41.417243Z","end":"2026-07-01T09:31:41.639977Z","steps":["trace[559613829] 'agreement among raft nodes before linearized reading' (duration: 222.038328ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:31:41.639975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.800156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-01T09:31:41.640018Z","caller":"traceutil/trace.go:171","msg":"trace[405480392] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1308; }","duration":"183.900339ms","start":"2026-07-01T09:31:41.456104Z","end":"2026-07-01T09:31:41.640004Z","steps":["trace[405480392] 'agreement among raft nodes before linearized reading' (duration: 183.729515ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:41.640053Z","caller":"traceutil/trace.go:171","msg":"trace[1408846959] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1308; }","duration":"183.93022ms","start":"2026-07-01T09:31:41.456104Z","end":"2026-07-01T09:31:41.640035Z","steps":["trace[1408846959] 'agreement among raft nodes before linearized reading' (duration: 183.701244ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:41.813437Z","caller":"traceutil/trace.go:171","msg":"trace[1475236861] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"168.741548ms","start":"2026-07-01T09:31:41.644667Z","end":"2026-07-01T09:31:41.813408Z","steps":["trace[1475236861] 'process raft request' (duration: 115.209239ms)","trace[1475236861] 'compare' (duration: 53.404025ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:31:41.816909Z","caller":"traceutil/trace.go:171","msg":"trace[1535331329] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"171.772169ms","start":"2026-07-01T09:31:41.645114Z","end":"2026-07-01T09:31:41.816886Z","steps":["trace[1535331329] 'process raft request' (duration: 171.659886ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:41.816998Z","caller":"traceutil/trace.go:171","msg":"trace[220716179] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"171.995956ms","start":"2026-07-01T09:31:41.644966Z","end":"2026-07-01T09:31:41.816962Z","steps":["trace[220716179] 'process raft request' (duration: 171.769419ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:41.817202Z","caller":"traceutil/trace.go:171","msg":"trace[620964043] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"171.014039ms","start":"2026-07-01T09:31:41.64616Z","end":"2026-07-01T09:31:41.817174Z","steps":["trace[620964043] 'process raft request' (duration: 170.66975ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:41.81703Z","caller":"traceutil/trace.go:171","msg":"trace[334622273] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"172.021997ms","start":"2026-07-01T09:31:41.644923Z","end":"2026-07-01T09:31:41.816945Z","steps":["trace[334622273] 'process raft request' (duration: 171.492553ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:41.817395Z","caller":"traceutil/trace.go:171","msg":"trace[871655614] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"170.884496ms","start":"2026-07-01T09:31:41.646498Z","end":"2026-07-01T09:31:41.817383Z","steps":["trace[871655614] 'process raft request' (duration: 170.639529ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:31:50.300005Z","caller":"traceutil/trace.go:171","msg":"trace[2024668243] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"124.691487ms","start":"2026-07-01T09:31:50.175285Z","end":"2026-07-01T09:31:50.299976Z","steps":["trace[2024668243] 'process raft request' (duration: 107.650923ms)","trace[2024668243] 'compare' (duration: 16.798447ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:32:00.745121Z","caller":"traceutil/trace.go:171","msg":"trace[1901466293] transaction","detail":"{read_only:false; response_revision:1435; number_of_response:1; }","duration":"210.404062ms","start":"2026-07-01T09:32:00.534691Z","end":"2026-07-01T09:32:00.745095Z","steps":["trace[1901466293] 'process raft request' (duration: 210.269209ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:33:28.564594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.081415ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T09:33:28.565034Z","caller":"traceutil/trace.go:171","msg":"trace[463488995] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"151.381669ms","start":"2026-07-01T09:33:28.41364Z","end":"2026-07-01T09:33:28.565022Z","steps":["trace[463488995] 'process raft request' (duration: 151.312207ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T09:33:28.565245Z","caller":"traceutil/trace.go:171","msg":"trace[1910259019] linearizableReadLoop","detail":"{readStateIndex:1913; appliedIndex:1912; }","duration":"155.090859ms","start":"2026-07-01T09:33:28.410122Z","end":"2026-07-01T09:33:28.565213Z","steps":["trace[1910259019] 'read index received' (duration: 50.332226ms)","trace[1910259019] 'applied index is now lower than readState.Index' (duration: 104.756453ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T09:33:28.565339Z","caller":"traceutil/trace.go:171","msg":"trace[1046848] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"184.345758ms","start":"2026-07-01T09:33:28.380955Z","end":"2026-07-01T09:33:28.565301Z","steps":["trace[1046848] 'process raft request' (duration: 79.486812ms)","trace[1046848] 'compare' (duration: 103.929811ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T09:33:28.565466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.470102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T09:33:28.5655Z","caller":"traceutil/trace.go:171","msg":"trace[1055352171] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1836; }","duration":"115.532594ms","start":"2026-07-01T09:33:28.449958Z","end":"2026-07-01T09:33:28.56549Z","steps":["trace[1055352171] 'agreement among raft nodes before linearized reading' (duration: 115.475182ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:33:28.565478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.709086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-07-01T09:33:28.5656Z","caller":"traceutil/trace.go:171","msg":"trace[251791042] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1836; }","duration":"175.849679ms","start":"2026-07-01T09:33:28.389724Z","end":"2026-07-01T09:33:28.565574Z","steps":["trace[251791042] 'agreement among raft nodes before linearized reading' (duration: 175.596302ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T09:33:28.565656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.115932ms","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-07-01T09:33:28.56573Z","caller":"traceutil/trace.go:171","msg":"trace[236533301] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1836; }","duration":"184.200064ms","start":"2026-07-01T09:33:28.381494Z","end":"2026-07-01T09:33:28.565694Z","steps":["trace[236533301] 'agreement among raft nodes before linearized reading' (duration: 183.887346ms)"],"step_count":1}