{"level":"warn","ts":"2026-04-07T09:39:35.142318Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T09:39:35.142417Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.244: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.244:2380","--initial-cluster=instance=https://199.204.45.244:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.244:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.244:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-07T09:39:35.142501Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-07T09:39:35.142508Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-04-07T09:39:35.142526Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T09:39:35.143162Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"]} {"level":"info","ts":"2026-04-07T09:39:35.143243Z","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.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.244:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-07T09:39:35.147303Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.849782ms"} {"level":"info","ts":"2026-04-07T09:39:35.153265Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1686e9b1ea717edf","cluster-id":"71c60fe001ca5b3c"} {"level":"info","ts":"2026-04-07T09:39:35.153334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T09:39:35.153356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 0"} {"level":"info","ts":"2026-04-07T09:39:35.153368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1686e9b1ea717edf [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T09:39:35.153376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became follower at term 1"} {"level":"info","ts":"2026-04-07T09:39:35.153411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"warn","ts":"2026-04-07T09:39:35.15839Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T09:39:35.163784Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T09:39:35.166046Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-07T09:39:35.168632Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1686e9b1ea717edf","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T09:39:35.168821Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1686e9b1ea717edf","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T09:39:35.168913Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T09:39:35.168977Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T09:39:35.16899Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-07T09:39:35.169601Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf switched to configuration voters=(1623241666065432287)"} {"level":"info","ts":"2026-04-07T09:39:35.169739Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","added-peer-id":"1686e9b1ea717edf","added-peer-peer-urls":["https://199.204.45.244:2380"]} {"level":"info","ts":"2026-04-07T09:39:35.175199Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-07T09:39:35.17541Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1686e9b1ea717edf","initial-advertise-peer-urls":["https://199.204.45.244:2380"],"listen-peer-urls":["https://199.204.45.244:2380"],"advertise-client-urls":["https://199.204.45.244:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.244:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T09:39:35.175436Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T09:39:35.175507Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-04-07T09:39:35.175518Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.244:2380"} {"level":"info","ts":"2026-04-07T09:39:35.254689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T09:39:35.25475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T09:39:35.254904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgPreVoteResp from 1686e9b1ea717edf at term 1"} {"level":"info","ts":"2026-04-07T09:39:35.254951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became candidate at term 2"} {"level":"info","ts":"2026-04-07T09:39:35.254999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf received MsgVoteResp from 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-04-07T09:39:35.255065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1686e9b1ea717edf became leader at term 2"} {"level":"info","ts":"2026-04-07T09:39:35.255121Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1686e9b1ea717edf elected leader 1686e9b1ea717edf at term 2"} {"level":"info","ts":"2026-04-07T09:39:35.25601Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:39:35.256795Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1686e9b1ea717edf","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.244:2379]}","request-path":"/0/members/1686e9b1ea717edf/attributes","cluster-id":"71c60fe001ca5b3c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T09:39:35.256976Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:39:35.257021Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T09:39:35.257103Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"71c60fe001ca5b3c","local-member-id":"1686e9b1ea717edf","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:39:35.25724Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T09:39:35.257276Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T09:39:35.257318Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:39:35.257386Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T09:39:35.260452Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-07T09:39:35.261147Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.244:2379"} {"level":"info","ts":"2026-04-07T09:39:50.402844Z","caller":"traceutil/trace.go:171","msg":"trace[899698413] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"206.650907ms","start":"2026-04-07T09:39:50.196166Z","end":"2026-04-07T09:39:50.402817Z","steps":["trace[899698413] 'process raft request' (duration: 206.515403ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:50.404499Z","caller":"traceutil/trace.go:171","msg":"trace[1528382000] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"104.68434ms","start":"2026-04-07T09:39:50.29979Z","end":"2026-04-07T09:39:50.404475Z","steps":["trace[1528382000] 'process raft request' (duration: 104.551416ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:52.194638Z","caller":"traceutil/trace.go:171","msg":"trace[1587984259] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"184.891544ms","start":"2026-04-07T09:39:52.009723Z","end":"2026-04-07T09:39:52.194615Z","steps":["trace[1587984259] 'process raft request' (duration: 184.757909ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:39:57.07144Z","caller":"traceutil/trace.go:171","msg":"trace[961926843] transaction","detail":"{read_only:false; response_revision:412; number_of_response:1; }","duration":"114.134548ms","start":"2026-04-07T09:39:56.957282Z","end":"2026-04-07T09:39:57.071416Z","steps":["trace[961926843] 'process raft request' (duration: 113.843841ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:00.422774Z","caller":"traceutil/trace.go:171","msg":"trace[1687133302] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"134.663299ms","start":"2026-04-07T09:40:00.288086Z","end":"2026-04-07T09:40:00.422749Z","steps":["trace[1687133302] 'process raft request' (duration: 134.517695ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.604456Z","caller":"traceutil/trace.go:171","msg":"trace[1893705175] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"299.540794ms","start":"2026-04-07T09:40:04.304889Z","end":"2026-04-07T09:40:04.604429Z","steps":["trace[1893705175] 'process raft request' (duration: 299.313868ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.610517Z","caller":"traceutil/trace.go:171","msg":"trace[773369740] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"301.501027ms","start":"2026-04-07T09:40:04.308986Z","end":"2026-04-07T09:40:04.610487Z","steps":["trace[773369740] 'process raft request' (duration: 301.312342ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.610668Z","caller":"traceutil/trace.go:171","msg":"trace[1169113362] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"281.468938ms","start":"2026-04-07T09:40:04.329105Z","end":"2026-04-07T09:40:04.610574Z","steps":["trace[1169113362] 'process raft request' (duration: 281.346975ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.610803Z","caller":"traceutil/trace.go:171","msg":"trace[402029473] linearizableReadLoop","detail":"{readStateIndex:492; appliedIndex:481; }","duration":"173.545194ms","start":"2026-04-07T09:40:04.437235Z","end":"2026-04-07T09:40:04.610781Z","steps":["trace[402029473] 'read index received' (duration: 166.916829ms)","trace[402029473] 'applied index is now lower than readState.Index' (duration: 6.627385ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:04.610869Z","caller":"traceutil/trace.go:171","msg":"trace[1125281292] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"293.421372ms","start":"2026-04-07T09:40:04.317442Z","end":"2026-04-07T09:40:04.610863Z","steps":["trace[1125281292] 'process raft request' (duration: 292.97856ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.610917Z","caller":"traceutil/trace.go:171","msg":"trace[550603518] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"273.289063ms","start":"2026-04-07T09:40:04.337619Z","end":"2026-04-07T09:40:04.610908Z","steps":["trace[550603518] 'process raft request' (duration: 272.944614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:04.610912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:04.308968Z","time spent":"301.598639ms","remote":"127.0.0.1:39638","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:40:04.61102Z","caller":"traceutil/trace.go:171","msg":"trace[2144995997] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"273.528749ms","start":"2026-04-07T09:40:04.337483Z","end":"2026-04-07T09:40:04.611012Z","steps":["trace[2144995997] 'process raft request' (duration: 273.024315ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.611046Z","caller":"traceutil/trace.go:171","msg":"trace[953514289] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"270.290774ms","start":"2026-04-07T09:40:04.34075Z","end":"2026-04-07T09:40:04.611041Z","steps":["trace[953514289] 'process raft request' (duration: 269.848662ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.611062Z","caller":"traceutil/trace.go:171","msg":"trace[367115652] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"147.299331ms","start":"2026-04-07T09:40:04.463755Z","end":"2026-04-07T09:40:04.611054Z","steps":["trace[367115652] 'process raft request' (duration: 146.981612ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.611019Z","caller":"traceutil/trace.go:171","msg":"trace[1161140263] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"249.750732ms","start":"2026-04-07T09:40:04.361261Z","end":"2026-04-07T09:40:04.611012Z","steps":["trace[1161140263] 'process raft request' (duration: 249.417193ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.611111Z","caller":"traceutil/trace.go:171","msg":"trace[122987032] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"270.298113ms","start":"2026-04-07T09:40:04.340802Z","end":"2026-04-07T09:40:04.6111Z","steps":["trace[122987032] 'process raft request' (duration: 269.83104ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.610832Z","caller":"traceutil/trace.go:171","msg":"trace[362620454] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"278.334776ms","start":"2026-04-07T09:40:04.332486Z","end":"2026-04-07T09:40:04.61082Z","steps":["trace[362620454] 'process raft request' (duration: 277.992487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:04.611181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.940284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T09:40:04.611242Z","caller":"traceutil/trace.go:171","msg":"trace[1396817465] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"174.052386ms","start":"2026-04-07T09:40:04.437178Z","end":"2026-04-07T09:40:04.611231Z","steps":["trace[1396817465] 'agreement among raft nodes before linearized reading' (duration: 173.928883ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:04.610753Z","caller":"traceutil/trace.go:171","msg":"trace[1801816572] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"273.173259ms","start":"2026-04-07T09:40:04.33754Z","end":"2026-04-07T09:40:04.610714Z","steps":["trace[1801816572] 'process raft request' (duration: 272.997205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:09.600288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.822834ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:40:09.600435Z","caller":"traceutil/trace.go:171","msg":"trace[803008633] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"415.49791ms","start":"2026-04-07T09:40:09.184917Z","end":"2026-04-07T09:40:09.600415Z","steps":["trace[803008633] 'read index received' (duration: 176.331266ms)","trace[803008633] 'applied index is now lower than readState.Index' (duration: 239.164694ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:09.600523Z","caller":"traceutil/trace.go:171","msg":"trace[897201104] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"776.30151ms","start":"2026-04-07T09:40:08.824209Z","end":"2026-04-07T09:40:09.60051Z","steps":["trace[897201104] 'process raft request' (duration: 537.018744ms)","trace[897201104] 'compare' (duration: 238.557357ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:09.600605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:08.824192Z","time spent":"776.358281ms","remote":"127.0.0.1:34040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":897,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:40:09.600918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.991062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T09:40:09.600955Z","caller":"traceutil/trace.go:171","msg":"trace[1521346850] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:557; }","duration":"416.051164ms","start":"2026-04-07T09:40:09.184891Z","end":"2026-04-07T09:40:09.600942Z","steps":["trace[1521346850] 'agreement among raft nodes before linearized reading' (duration: 415.91246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:09.600987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:09.184878Z","time spent":"416.101885ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T09:40:09.600997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.978592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-07T09:40:09.601027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.790688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-07T09:40:09.601048Z","caller":"traceutil/trace.go:171","msg":"trace[2128559242] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"416.037654ms","start":"2026-04-07T09:40:09.184995Z","end":"2026-04-07T09:40:09.601032Z","steps":["trace[2128559242] 'agreement among raft nodes before linearized reading' (duration: 415.938641ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:09.601102Z","caller":"traceutil/trace.go:171","msg":"trace[551711928] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:557; }","duration":"398.892192ms","start":"2026-04-07T09:40:09.202191Z","end":"2026-04-07T09:40:09.601083Z","steps":["trace[551711928] 'agreement among raft nodes before linearized reading' (duration: 398.758768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:09.601117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:09.184991Z","time spent":"416.112066ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T09:40:09.60114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:09.202108Z","time spent":"399.024156ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T09:40:09.872965Z","caller":"traceutil/trace.go:171","msg":"trace[1983062755] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"268.057695ms","start":"2026-04-07T09:40:09.604871Z","end":"2026-04-07T09:40:09.872929Z","steps":["trace[1983062755] 'process raft request' (duration: 232.547658ms)","trace[1983062755] 'compare' (duration: 31.620574ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:09.87304Z","caller":"traceutil/trace.go:171","msg":"trace[1410526042] linearizableReadLoop","detail":"{readStateIndex:584; appliedIndex:581; }","duration":"262.406246ms","start":"2026-04-07T09:40:09.610572Z","end":"2026-04-07T09:40:09.872978Z","steps":["trace[1410526042] 'read index received' (duration: 226.819108ms)","trace[1410526042] 'applied index is now lower than readState.Index' (duration: 35.569887ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:09.873226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.634571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:09.873289Z","caller":"traceutil/trace.go:171","msg":"trace[1724216449] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:560; }","duration":"262.712474ms","start":"2026-04-07T09:40:09.610542Z","end":"2026-04-07T09:40:09.873255Z","steps":["trace[1724216449] 'agreement among raft nodes before linearized reading' (duration: 262.611331ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:09.873297Z","caller":"traceutil/trace.go:171","msg":"trace[618250147] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"268.118186ms","start":"2026-04-07T09:40:09.605159Z","end":"2026-04-07T09:40:09.873277Z","steps":["trace[618250147] 'process raft request' (duration: 264.310946ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:09.873569Z","caller":"traceutil/trace.go:171","msg":"trace[1392241173] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"268.169188ms","start":"2026-04-07T09:40:09.605372Z","end":"2026-04-07T09:40:09.873541Z","steps":["trace[1392241173] 'process raft request' (duration: 267.50537ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:12.453118Z","caller":"traceutil/trace.go:171","msg":"trace[1807435314] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"326.511435ms","start":"2026-04-07T09:40:12.126585Z","end":"2026-04-07T09:40:12.453096Z","steps":["trace[1807435314] 'process raft request' (duration: 326.388252ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:12.453368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:12.126575Z","time spent":"326.607817ms","remote":"127.0.0.1:39764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:40:13.038362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198835631125974,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:40:13.456597Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.000905209s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T09:40:13.458055Z","caller":"traceutil/trace.go:171","msg":"trace[1798519848] linearizableReadLoop","detail":"{readStateIndex:602; appliedIndex:601; }","duration":"920.712625ms","start":"2026-04-07T09:40:12.537325Z","end":"2026-04-07T09:40:13.458037Z","steps":["trace[1798519848] 'read index received' (duration: 919.41375ms)","trace[1798519848] 'applied index is now lower than readState.Index' (duration: 1.298045ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:13.458412Z","caller":"traceutil/trace.go:171","msg":"trace[191252973] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.079005587s","start":"2026-04-07T09:40:12.379113Z","end":"2026-04-07T09:40:13.458119Z","steps":["trace[191252973] 'process raft request' (duration: 1.077882477s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:13.458663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:12.379089Z","time spent":"1.07950323s","remote":"127.0.0.1:39668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:40:13.460301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"922.947354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:13.46044Z","caller":"traceutil/trace.go:171","msg":"trace[307803625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:578; }","duration":"923.094047ms","start":"2026-04-07T09:40:12.537284Z","end":"2026-04-07T09:40:13.460378Z","steps":["trace[307803625] 'agreement among raft nodes before linearized reading' (duration: 920.844888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:13.460499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:12.537266Z","time spent":"923.218041ms","remote":"127.0.0.1:39592","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:40:13.461001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.025265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T09:40:13.461065Z","caller":"traceutil/trace.go:171","msg":"trace[1792952819] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:578; }","duration":"797.110048ms","start":"2026-04-07T09:40:12.663927Z","end":"2026-04-07T09:40:13.461037Z","steps":["trace[1792952819] 'agreement among raft nodes before linearized reading' (duration: 794.269844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:13.461105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:12.663906Z","time spent":"797.18898ms","remote":"127.0.0.1:33994","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-04-07T09:40:14.036176Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9142198835631125978,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T09:40:14.756506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.483329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:40:14.756739Z","caller":"traceutil/trace.go:171","msg":"trace[1363814475] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.222900189s","start":"2026-04-07T09:40:13.533828Z","end":"2026-04-07T09:40:14.756728Z","steps":["trace[1363814475] 'process raft request' (duration: 1.222818767s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.756793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:13.533803Z","time spent":"1.222970151s","remote":"127.0.0.1:39820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T09:40:14.756894Z","caller":"traceutil/trace.go:171","msg":"trace[810453500] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.291640991s","start":"2026-04-07T09:40:13.465229Z","end":"2026-04-07T09:40:14.75687Z","steps":["trace[810453500] 'process raft request' (duration: 765.6815ms)","trace[810453500] 'compare' (duration: 524.787839ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:14.75704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:13.465208Z","time spent":"1.291740114s","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:40:14.777585Z","caller":"traceutil/trace.go:171","msg":"trace[1199017732] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:602; }","duration":"1.241577793s","start":"2026-04-07T09:40:13.535983Z","end":"2026-04-07T09:40:14.77756Z","steps":["trace[1199017732] 'read index received' (duration: 694.943926ms)","trace[1199017732] 'applied index is now lower than readState.Index' (duration: 546.632336ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:14.777738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.241731126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.777802Z","caller":"traceutil/trace.go:171","msg":"trace[461104427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"1.241833868s","start":"2026-04-07T09:40:13.535952Z","end":"2026-04-07T09:40:14.777786Z","steps":["trace[461104427] 'agreement among raft nodes before linearized reading' (duration: 1.241707905s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:13.53594Z","time spent":"1.242835065s","remote":"127.0.0.1:39598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:40:14.777974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.847484ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T09:40:14.777953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.817799ms","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-04-07T09:40:14.779003Z","caller":"traceutil/trace.go:171","msg":"trace[405401310] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"150.966839ms","start":"2026-04-07T09:40:14.628026Z","end":"2026-04-07T09:40:14.778992Z","steps":["trace[405401310] 'agreement among raft nodes before linearized reading' (duration: 149.793938ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:14.779012Z","caller":"traceutil/trace.go:171","msg":"trace[898126567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"892.83546ms","start":"2026-04-07T09:40:13.886063Z","end":"2026-04-07T09:40:14.778899Z","steps":["trace[898126567] 'agreement among raft nodes before linearized reading' (duration: 891.68604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.779047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:13.886042Z","time spent":"892.996245ms","remote":"127.0.0.1:33994","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-04-07T09:40:14.777976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.061109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.779111Z","caller":"traceutil/trace.go:171","msg":"trace[1206449146] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"328.305722ms","start":"2026-04-07T09:40:14.450799Z","end":"2026-04-07T09:40:14.779105Z","steps":["trace[1206449146] 'agreement among raft nodes before linearized reading' (duration: 327.040288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.779135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.450777Z","time spent":"328.349544ms","remote":"127.0.0.1:44452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:40:14.778014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.329307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.779292Z","caller":"traceutil/trace.go:171","msg":"trace[7264490] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"328.6362ms","start":"2026-04-07T09:40:14.450647Z","end":"2026-04-07T09:40:14.779283Z","steps":["trace[7264490] 'agreement among raft nodes before linearized reading' (duration: 327.346856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.779324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.450632Z","time spent":"328.683112ms","remote":"127.0.0.1:44452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:40:14.778019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.184341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.779382Z","caller":"traceutil/trace.go:171","msg":"trace[677214495] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:580; }","duration":"164.561137ms","start":"2026-04-07T09:40:14.614815Z","end":"2026-04-07T09:40:14.779376Z","steps":["trace[677214495] 'agreement among raft nodes before linearized reading' (duration: 163.18354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.77805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.53204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:40:14.77807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.892715ms","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-04-07T09:40:14.779635Z","caller":"traceutil/trace.go:171","msg":"trace[2144181700] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:580; }","duration":"165.114791ms","start":"2026-04-07T09:40:14.614495Z","end":"2026-04-07T09:40:14.77961Z","steps":["trace[2144181700] 'agreement among raft nodes before linearized reading' (duration: 163.537889ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:14.779679Z","caller":"traceutil/trace.go:171","msg":"trace[1221872219] 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:580; }","duration":"380.513048ms","start":"2026-04-07T09:40:14.399133Z","end":"2026-04-07T09:40:14.779646Z","steps":["trace[1221872219] 'agreement among raft nodes before linearized reading' (duration: 378.893885ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.779777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.399126Z","time spent":"380.641163ms","remote":"127.0.0.1:44450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"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-04-07T09:40:14.778104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.646335ms","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-04-07T09:40:14.779886Z","caller":"traceutil/trace.go:171","msg":"trace[538738316] 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:580; }","duration":"381.454383ms","start":"2026-04-07T09:40:14.398423Z","end":"2026-04-07T09:40:14.779878Z","steps":["trace[538738316] 'agreement among raft nodes before linearized reading' (duration: 379.659976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.77991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.398406Z","time spent":"381.496215ms","remote":"127.0.0.1:44450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"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-04-07T09:40:14.77813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.740018ms","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-04-07T09:40:14.780008Z","caller":"traceutil/trace.go:171","msg":"trace[638061131] 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:580; }","duration":"381.642128ms","start":"2026-04-07T09:40:14.398357Z","end":"2026-04-07T09:40:14.779999Z","steps":["trace[638061131] 'agreement among raft nodes before linearized reading' (duration: 379.760398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.780032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.398345Z","time spent":"381.679249ms","remote":"127.0.0.1:44450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"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-04-07T09:40:14.778136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.43364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:40:14.778153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.409948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.780283Z","caller":"traceutil/trace.go:171","msg":"trace[1506023041] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:580; }","duration":"403.570285ms","start":"2026-04-07T09:40:14.376704Z","end":"2026-04-07T09:40:14.780274Z","steps":["trace[1506023041] 'agreement among raft nodes before linearized reading' (duration: 401.436979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.780311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.376685Z","time spent":"403.616767ms","remote":"127.0.0.1:44436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"info","ts":"2026-04-07T09:40:14.78033Z","caller":"traceutil/trace.go:171","msg":"trace[8811443] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:580; }","duration":"255.654228ms","start":"2026-04-07T09:40:14.524662Z","end":"2026-04-07T09:40:14.780316Z","steps":["trace[8811443] 'agreement among raft nodes before linearized reading' (duration: 253.45347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.666561ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.780416Z","caller":"traceutil/trace.go:171","msg":"trace[792585612] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:580; }","duration":"256.947091ms","start":"2026-04-07T09:40:14.523461Z","end":"2026-04-07T09:40:14.780408Z","steps":["trace[792585612] 'agreement among raft nodes before linearized reading' (duration: 254.685391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.791648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.780532Z","caller":"traceutil/trace.go:171","msg":"trace[70158095] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:580; }","duration":"404.13605ms","start":"2026-04-07T09:40:14.37638Z","end":"2026-04-07T09:40:14.780516Z","steps":["trace[70158095] 'agreement among raft nodes before linearized reading' (duration: 401.784528ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.780582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.376359Z","time spent":"404.194133ms","remote":"127.0.0.1:44436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:40:14.778187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.770054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.780669Z","caller":"traceutil/trace.go:171","msg":"trace[1702178662] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:580; }","duration":"257.25006ms","start":"2026-04-07T09:40:14.523412Z","end":"2026-04-07T09:40:14.780662Z","steps":["trace[1702178662] 'agreement among raft nodes before linearized reading' (duration: 254.760414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.895061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.780768Z","caller":"traceutil/trace.go:171","msg":"trace[1106048291] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:580; }","duration":"404.48449ms","start":"2026-04-07T09:40:14.376277Z","end":"2026-04-07T09:40:14.780761Z","steps":["trace[1106048291] 'agreement among raft nodes before linearized reading' (duration: 401.911672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.780795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:14.37626Z","time spent":"404.526331ms","remote":"127.0.0.1:44436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-04-07T09:40:14.778213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.702707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.780933Z","caller":"traceutil/trace.go:171","msg":"trace[700102153] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"286.434588ms","start":"2026-04-07T09:40:14.49449Z","end":"2026-04-07T09:40:14.780925Z","steps":["trace[700102153] 'agreement among raft nodes before linearized reading' (duration: 283.708386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.77826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"891.412644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T09:40:14.781023Z","caller":"traceutil/trace.go:171","msg":"trace[2044127596] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"894.191196ms","start":"2026-04-07T09:40:13.886825Z","end":"2026-04-07T09:40:14.781017Z","steps":["trace[2044127596] 'agreement among raft nodes before linearized reading' (duration: 891.387022ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.781046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:13.886815Z","time spent":"894.224577ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-07T09:40:14.778257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.950844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.781118Z","caller":"traceutil/trace.go:171","msg":"trace[533458886] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"286.8448ms","start":"2026-04-07T09:40:14.494267Z","end":"2026-04-07T09:40:14.781111Z","steps":["trace[533458886] 'agreement among raft nodes before linearized reading' (duration: 283.976495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.77829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.031756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.781252Z","caller":"traceutil/trace.go:171","msg":"trace[1784389813] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"286.991793ms","start":"2026-04-07T09:40:14.494253Z","end":"2026-04-07T09:40:14.781245Z","steps":["trace[1784389813] 'agreement among raft nodes before linearized reading' (duration: 284.023015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.598602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.78135Z","caller":"traceutil/trace.go:171","msg":"trace[793024296] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:580; }","duration":"111.654933ms","start":"2026-04-07T09:40:14.669688Z","end":"2026-04-07T09:40:14.781343Z","steps":["trace[793024296] 'agreement among raft nodes before linearized reading' (duration: 108.618013ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.612923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.781477Z","caller":"traceutil/trace.go:171","msg":"trace[233695023] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:580; }","duration":"111.779486ms","start":"2026-04-07T09:40:14.669689Z","end":"2026-04-07T09:40:14.781469Z","steps":["trace[233695023] 'agreement among raft nodes before linearized reading' (duration: 108.619163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.885956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.781625Z","caller":"traceutil/trace.go:171","msg":"trace[2011066674] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:580; }","duration":"135.128671ms","start":"2026-04-07T09:40:14.646481Z","end":"2026-04-07T09:40:14.78161Z","steps":["trace[2011066674] 'agreement among raft nodes before linearized reading' (duration: 131.887267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.284916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.781781Z","caller":"traceutil/trace.go:171","msg":"trace[796341550] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:580; }","duration":"135.653665ms","start":"2026-04-07T09:40:14.646119Z","end":"2026-04-07T09:40:14.781772Z","steps":["trace[796341550] 'agreement among raft nodes before linearized reading' (duration: 132.294477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.334328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.781846Z","caller":"traceutil/trace.go:171","msg":"trace[2083418716] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:580; }","duration":"135.733887ms","start":"2026-04-07T09:40:14.646105Z","end":"2026-04-07T09:40:14.781839Z","steps":["trace[2083418716] 'agreement among raft nodes before linearized reading' (duration: 132.339468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.225285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T09:40:14.781916Z","caller":"traceutil/trace.go:171","msg":"trace[1818825004] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"895.715597ms","start":"2026-04-07T09:40:13.886194Z","end":"2026-04-07T09:40:14.781909Z","steps":["trace[1818825004] 'agreement among raft nodes before linearized reading' (duration: 892.078301ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.781938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:13.88617Z","time spent":"895.760738ms","remote":"127.0.0.1:33994","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-04-07T09:40:14.778495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.86014ms","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":"info","ts":"2026-04-07T09:40:14.782023Z","caller":"traceutil/trace.go:171","msg":"trace[753956169] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"153.407733ms","start":"2026-04-07T09:40:14.628608Z","end":"2026-04-07T09:40:14.782016Z","steps":["trace[753956169] 'agreement among raft nodes before linearized reading' (duration: 149.868599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.423425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.78209Z","caller":"traceutil/trace.go:171","msg":"trace[503108968] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:580; }","duration":"154.014969ms","start":"2026-04-07T09:40:14.628066Z","end":"2026-04-07T09:40:14.782081Z","steps":["trace[503108968] 'agreement among raft nodes before linearized reading' (duration: 150.446555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.080288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.782155Z","caller":"traceutil/trace.go:171","msg":"trace[1950566657] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:580; }","duration":"111.646832ms","start":"2026-04-07T09:40:14.670499Z","end":"2026-04-07T09:40:14.782146Z","steps":["trace[1950566657] 'agreement among raft nodes before linearized reading' (duration: 108.077978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:14.778103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.618481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:14.782258Z","caller":"traceutil/trace.go:171","msg":"trace[802941190] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:580; }","duration":"167.788731ms","start":"2026-04-07T09:40:14.614455Z","end":"2026-04-07T09:40:14.782244Z","steps":["trace[802941190] 'agreement among raft nodes before linearized reading' (duration: 163.606861ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:29.864605Z","caller":"traceutil/trace.go:171","msg":"trace[170591154] linearizableReadLoop","detail":"{readStateIndex:769; appliedIndex:768; }","duration":"326.655988ms","start":"2026-04-07T09:40:29.537899Z","end":"2026-04-07T09:40:29.864555Z","steps":["trace[170591154] 'read index received' (duration: 326.382201ms)","trace[170591154] 'applied index is now lower than readState.Index' (duration: 272.437µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:29.864764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.853164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:29.864799Z","caller":"traceutil/trace.go:171","msg":"trace[654703185] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:740; }","duration":"326.936696ms","start":"2026-04-07T09:40:29.53785Z","end":"2026-04-07T09:40:29.864787Z","steps":["trace[654703185] 'agreement among raft nodes before linearized reading' (duration: 326.847494ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:29.864742Z","caller":"traceutil/trace.go:171","msg":"trace[687098671] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"636.608688ms","start":"2026-04-07T09:40:29.228051Z","end":"2026-04-07T09:40:29.86466Z","steps":["trace[687098671] 'process raft request' (duration: 636.32697ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:29.864844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:29.537832Z","time spent":"326.996188ms","remote":"127.0.0.1:39598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:40:29.865799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:29.228022Z","time spent":"636.841144ms","remote":"127.0.0.1:39764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:40:30.375478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.848622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-07T09:40:30.375562Z","caller":"traceutil/trace.go:171","msg":"trace[1805185107] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:740; }","duration":"311.025627ms","start":"2026-04-07T09:40:30.064519Z","end":"2026-04-07T09:40:30.375544Z","steps":["trace[1805185107] 'range keys from in-memory index tree' (duration: 310.651017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:30.3756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:40:30.064494Z","time spent":"311.095849ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-07T09:40:34.510305Z","caller":"traceutil/trace.go:171","msg":"trace[1490074183] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"102.363238ms","start":"2026-04-07T09:40:34.407918Z","end":"2026-04-07T09:40:34.510281Z","steps":["trace[1490074183] 'read index received' (duration: 102.221084ms)","trace[1490074183] 'applied index is now lower than readState.Index' (duration: 140.904µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:34.510415Z","caller":"traceutil/trace.go:171","msg":"trace[1786612708] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"248.208421ms","start":"2026-04-07T09:40:34.262172Z","end":"2026-04-07T09:40:34.51038Z","steps":["trace[1786612708] 'process raft request' (duration: 247.954135ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:34.510567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.627085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T09:40:34.510634Z","caller":"traceutil/trace.go:171","msg":"trace[983865344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:757; }","duration":"102.749778ms","start":"2026-04-07T09:40:34.407866Z","end":"2026-04-07T09:40:34.510615Z","steps":["trace[983865344] 'agreement among raft nodes before linearized reading' (duration: 102.553433ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.45272Z","caller":"traceutil/trace.go:171","msg":"trace[1799770758] linearizableReadLoop","detail":"{readStateIndex:917; appliedIndex:916; }","duration":"160.228457ms","start":"2026-04-07T09:40:45.292463Z","end":"2026-04-07T09:40:45.452691Z","steps":["trace[1799770758] 'read index received' (duration: 77.615401ms)","trace[1799770758] 'applied index is now lower than readState.Index' (duration: 82.611086ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:45.453172Z","caller":"traceutil/trace.go:171","msg":"trace[363140467] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"184.806439ms","start":"2026-04-07T09:40:45.268309Z","end":"2026-04-07T09:40:45.453115Z","steps":["trace[363140467] 'process raft request' (duration: 101.783662ms)","trace[363140467] 'compare' (duration: 82.299087ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:40:45.453391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.874564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-8tr5s\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-04-07T09:40:45.453473Z","caller":"traceutil/trace.go:171","msg":"trace[1514111467] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-8tr5s; range_end:; response_count:1; response_revision:884; }","duration":"161.034428ms","start":"2026-04-07T09:40:45.292424Z","end":"2026-04-07T09:40:45.453458Z","steps":["trace[1514111467] 'agreement among raft nodes before linearized reading' (duration: 160.443452ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.744875Z","caller":"traceutil/trace.go:171","msg":"trace[1591619696] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:917; }","duration":"235.391921ms","start":"2026-04-07T09:40:45.509461Z","end":"2026-04-07T09:40:45.744853Z","steps":["trace[1591619696] 'read index received' (duration: 235.173745ms)","trace[1591619696] 'applied index is now lower than readState.Index' (duration: 216.886µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:40:45.744948Z","caller":"traceutil/trace.go:171","msg":"trace[1277164747] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"281.575535ms","start":"2026-04-07T09:40:45.463353Z","end":"2026-04-07T09:40:45.744928Z","steps":["trace[1277164747] 'process raft request' (duration: 281.361559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.552665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:40:45.745071Z","caller":"traceutil/trace.go:171","msg":"trace[729031260] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:885; }","duration":"235.659079ms","start":"2026-04-07T09:40:45.509402Z","end":"2026-04-07T09:40:45.745061Z","steps":["trace[729031260] 'agreement among raft nodes before linearized reading' (duration: 235.566926ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.289911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745147Z","caller":"traceutil/trace.go:171","msg":"trace[1930242432] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:885; }","duration":"208.357003ms","start":"2026-04-07T09:40:45.536782Z","end":"2026-04-07T09:40:45.745139Z","steps":["trace[1930242432] 'agreement among raft nodes before linearized reading' (duration: 208.294211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.265859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:40:45.74526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.37319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745279Z","caller":"traceutil/trace.go:171","msg":"trace[1908400733] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:885; }","duration":"186.429052ms","start":"2026-04-07T09:40:45.558844Z","end":"2026-04-07T09:40:45.745273Z","steps":["trace[1908400733] 'agreement among raft nodes before linearized reading' (duration: 186.393071ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.745279Z","caller":"traceutil/trace.go:171","msg":"trace[1445734977] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:885; }","duration":"156.340711ms","start":"2026-04-07T09:40:45.588927Z","end":"2026-04-07T09:40:45.745267Z","steps":["trace[1445734977] 'agreement among raft nodes before linearized reading' (duration: 156.259189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.432222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:40:45.745306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.113709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:40:45.745373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.995167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:40:45.745375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.794353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745394Z","caller":"traceutil/trace.go:171","msg":"trace[934109114] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:885; }","duration":"186.844253ms","start":"2026-04-07T09:40:45.558545Z","end":"2026-04-07T09:40:45.74539Z","steps":["trace[934109114] 'agreement among raft nodes before linearized reading' (duration: 186.814902ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.745393Z","caller":"traceutil/trace.go:171","msg":"trace[486788899] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:885; }","duration":"141.027069ms","start":"2026-04-07T09:40:45.60436Z","end":"2026-04-07T09:40:45.745387Z","steps":["trace[486788899] 'agreement among raft nodes before linearized reading' (duration: 140.999638ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.745391Z","caller":"traceutil/trace.go:171","msg":"trace[575538466] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:885; }","duration":"171.223272ms","start":"2026-04-07T09:40:45.574149Z","end":"2026-04-07T09:40:45.745372Z","steps":["trace[575538466] 'agreement among raft nodes before linearized reading' (duration: 171.059177ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.466875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:40:45.745461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.953941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745479Z","caller":"traceutil/trace.go:171","msg":"trace[1659023040] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:885; }","duration":"155.997701ms","start":"2026-04-07T09:40:45.589476Z","end":"2026-04-07T09:40:45.745474Z","steps":["trace[1659023040] 'agreement among raft nodes before linearized reading' (duration: 155.973061ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.745472Z","caller":"traceutil/trace.go:171","msg":"trace[572255246] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:885; }","duration":"156.530626ms","start":"2026-04-07T09:40:45.588929Z","end":"2026-04-07T09:40:45.74546Z","steps":["trace[572255246] 'agreement among raft nodes before linearized reading' (duration: 156.473934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.625525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745513Z","caller":"traceutil/trace.go:171","msg":"trace[1365337926] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:885; }","duration":"141.760678ms","start":"2026-04-07T09:40:45.603747Z","end":"2026-04-07T09:40:45.745508Z","steps":["trace[1365337926] 'agreement among raft nodes before linearized reading' (duration: 141.631515ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.854965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745345Z","caller":"traceutil/trace.go:171","msg":"trace[1286441294] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:885; }","duration":"140.511005ms","start":"2026-04-07T09:40:45.604824Z","end":"2026-04-07T09:40:45.745335Z","steps":["trace[1286441294] 'agreement among raft nodes before linearized reading' (duration: 140.441773ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.557582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.74562Z","caller":"traceutil/trace.go:171","msg":"trace[2048807070] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:885; }","duration":"141.263636ms","start":"2026-04-07T09:40:45.60435Z","end":"2026-04-07T09:40:45.745613Z","steps":["trace[2048807070] 'agreement among raft nodes before linearized reading' (duration: 140.849284ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.745638Z","caller":"traceutil/trace.go:171","msg":"trace[1019435513] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:885; }","duration":"184.604303ms","start":"2026-04-07T09:40:45.561028Z","end":"2026-04-07T09:40:45.745632Z","steps":["trace[1019435513] 'agreement among raft nodes before linearized reading' (duration: 184.200102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.684038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745685Z","caller":"traceutil/trace.go:171","msg":"trace[1367018256] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:885; }","duration":"170.701038ms","start":"2026-04-07T09:40:45.574979Z","end":"2026-04-07T09:40:45.745681Z","steps":["trace[1367018256] 'agreement among raft nodes before linearized reading' (duration: 170.675788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:40:45.745731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.409628ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:40:45.745746Z","caller":"traceutil/trace.go:171","msg":"trace[1608840447] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:885; }","duration":"171.463549ms","start":"2026-04-07T09:40:45.574277Z","end":"2026-04-07T09:40:45.745741Z","steps":["trace[1608840447] 'agreement among raft nodes before linearized reading' (duration: 171.437428ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:40:45.856648Z","caller":"traceutil/trace.go:171","msg":"trace[1213078371] transaction","detail":"{read_only:false; response_revision:886; number_of_response:1; }","duration":"107.466935ms","start":"2026-04-07T09:40:45.749155Z","end":"2026-04-07T09:40:45.856622Z","steps":["trace[1213078371] 'process raft request' (duration: 69.922424ms)","trace[1213078371] 'compare' (duration: 37.318705ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:41:00.052048Z","caller":"traceutil/trace.go:171","msg":"trace[1986269725] transaction","detail":"{read_only:false; response_revision:939; number_of_response:1; }","duration":"155.19845ms","start":"2026-04-07T09:40:59.896827Z","end":"2026-04-07T09:41:00.052025Z","steps":["trace[1986269725] 'process raft request' (duration: 155.033485ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:00.82609Z","caller":"traceutil/trace.go:171","msg":"trace[143366353] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"118.621365ms","start":"2026-04-07T09:41:00.707444Z","end":"2026-04-07T09:41:00.826066Z","steps":["trace[143366353] 'process raft request' (duration: 118.449161ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:05.517797Z","caller":"traceutil/trace.go:171","msg":"trace[328432662] linearizableReadLoop","detail":"{readStateIndex:999; appliedIndex:997; }","duration":"209.173415ms","start":"2026-04-07T09:41:05.3086Z","end":"2026-04-07T09:41:05.517774Z","steps":["trace[328432662] 'read index received' (duration: 9.485336ms)","trace[328432662] 'applied index is now lower than readState.Index' (duration: 199.686819ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:41:05.517931Z","caller":"traceutil/trace.go:171","msg":"trace[1703194279] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"211.437366ms","start":"2026-04-07T09:41:05.306455Z","end":"2026-04-07T09:41:05.517892Z","steps":["trace[1703194279] 'process raft request' (duration: 211.19337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:05.518015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.39803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T09:41:05.518062Z","caller":"traceutil/trace.go:171","msg":"trace[1707724301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:960; }","duration":"209.503283ms","start":"2026-04-07T09:41:05.308546Z","end":"2026-04-07T09:41:05.518049Z","steps":["trace[1707724301] 'agreement among raft nodes before linearized reading' (duration: 209.331219ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:06.188021Z","caller":"traceutil/trace.go:171","msg":"trace[482631285] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"116.660923ms","start":"2026-04-07T09:41:06.071342Z","end":"2026-04-07T09:41:06.188002Z","steps":["trace[482631285] 'process raft request' (duration: 115.107881ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:06.758977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.856182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:06.759059Z","caller":"traceutil/trace.go:171","msg":"trace[81955300] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:962; }","duration":"171.016527ms","start":"2026-04-07T09:41:06.588021Z","end":"2026-04-07T09:41:06.759038Z","steps":["trace[81955300] 'count revisions from in-memory index tree' (duration: 170.77368ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:30.508499Z","caller":"traceutil/trace.go:171","msg":"trace[639556221] linearizableReadLoop","detail":"{readStateIndex:1086; appliedIndex:1085; }","duration":"155.037927ms","start":"2026-04-07T09:41:30.353437Z","end":"2026-04-07T09:41:30.508475Z","steps":["trace[639556221] 'read index received' (duration: 154.810401ms)","trace[639556221] 'applied index is now lower than readState.Index' (duration: 226.156µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:30.508677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.209631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:30.508719Z","caller":"traceutil/trace.go:171","msg":"trace[179256455] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1042; }","duration":"155.275583ms","start":"2026-04-07T09:41:30.353432Z","end":"2026-04-07T09:41:30.508708Z","steps":["trace[179256455] 'agreement among raft nodes before linearized reading' (duration: 155.18299ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:30.50881Z","caller":"traceutil/trace.go:171","msg":"trace[113000269] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"229.975695ms","start":"2026-04-07T09:41:30.278806Z","end":"2026-04-07T09:41:30.508782Z","steps":["trace[113000269] 'process raft request' (duration: 229.513423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:30.913385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.989435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:30.913444Z","caller":"traceutil/trace.go:171","msg":"trace[31181132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1042; }","duration":"377.085247ms","start":"2026-04-07T09:41:30.536344Z","end":"2026-04-07T09:41:30.91343Z","steps":["trace[31181132] 'range keys from in-memory index tree' (duration: 376.866281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:30.913471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:30.53633Z","time spent":"377.135639ms","remote":"127.0.0.1:39598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:41:30.913481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.495141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:30.91356Z","caller":"traceutil/trace.go:171","msg":"trace[357023219] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1042; }","duration":"239.623495ms","start":"2026-04-07T09:41:30.673919Z","end":"2026-04-07T09:41:30.913543Z","steps":["trace[357023219] 'count revisions from in-memory index tree' (duration: 239.363677ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:31.527293Z","caller":"traceutil/trace.go:171","msg":"trace[453838251] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"139.096747ms","start":"2026-04-07T09:41:31.388163Z","end":"2026-04-07T09:41:31.52726Z","steps":["trace[453838251] 'process raft request' (duration: 138.883031ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:31.643914Z","caller":"traceutil/trace.go:171","msg":"trace[1932550358] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"104.641009ms","start":"2026-04-07T09:41:31.539246Z","end":"2026-04-07T09:41:31.643887Z","steps":["trace[1932550358] 'read index received' (duration: 78.028962ms)","trace[1932550358] 'applied index is now lower than readState.Index' (duration: 26.610747ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:31.644071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.810384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:31.644111Z","caller":"traceutil/trace.go:171","msg":"trace[1226635942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1045; }","duration":"104.882815ms","start":"2026-04-07T09:41:31.539216Z","end":"2026-04-07T09:41:31.644099Z","steps":["trace[1226635942] 'agreement among raft nodes before linearized reading' (duration: 104.768052ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:31.644325Z","caller":"traceutil/trace.go:171","msg":"trace[2009781234] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"112.48868ms","start":"2026-04-07T09:41:31.531818Z","end":"2026-04-07T09:41:31.644307Z","steps":["trace[2009781234] 'process raft request' (duration: 85.472402ms)","trace[2009781234] 'compare' (duration: 26.494834ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:41:31.979808Z","caller":"traceutil/trace.go:171","msg":"trace[187304664] linearizableReadLoop","detail":"{readStateIndex:1090; appliedIndex:1089; }","duration":"218.426683ms","start":"2026-04-07T09:41:31.761355Z","end":"2026-04-07T09:41:31.979781Z","steps":["trace[187304664] 'read index received' (duration: 164.705227ms)","trace[187304664] 'applied index is now lower than readState.Index' (duration: 53.718886ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:41:31.979822Z","caller":"traceutil/trace.go:171","msg":"trace[935654797] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"265.080901ms","start":"2026-04-07T09:41:31.714715Z","end":"2026-04-07T09:41:31.979796Z","steps":["trace[935654797] 'process raft request' (duration: 211.312272ms)","trace[935654797] 'compare' (duration: 53.47051ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:31.980094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.782143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:41:31.980223Z","caller":"traceutil/trace.go:171","msg":"trace[480132142] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1046; }","duration":"218.991729ms","start":"2026-04-07T09:41:31.761212Z","end":"2026-04-07T09:41:31.980204Z","steps":["trace[480132142] 'agreement among raft nodes before linearized reading' (duration: 218.762803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:31.980676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.111023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-07T09:41:31.980765Z","caller":"traceutil/trace.go:171","msg":"trace[2116718681] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1046; }","duration":"147.244316ms","start":"2026-04-07T09:41:31.833509Z","end":"2026-04-07T09:41:31.980753Z","steps":["trace[2116718681] 'agreement among raft nodes before linearized reading' (duration: 147.039671ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:32.627398Z","caller":"traceutil/trace.go:171","msg":"trace[1797366830] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"113.479946ms","start":"2026-04-07T09:41:32.513888Z","end":"2026-04-07T09:41:32.627368Z","steps":["trace[1797366830] 'process raft request' (duration: 70.447098ms)","trace[1797366830] 'compare' (duration: 42.585537ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:33.940695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.285403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:41:33.940736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.721978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T09:41:33.940779Z","caller":"traceutil/trace.go:171","msg":"trace[624542964] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1051; }","duration":"292.410078ms","start":"2026-04-07T09:41:33.648347Z","end":"2026-04-07T09:41:33.940757Z","steps":["trace[624542964] 'count revisions from in-memory index tree' (duration: 292.1749ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:33.940856Z","caller":"traceutil/trace.go:171","msg":"trace[1028335786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1051; }","duration":"291.908954ms","start":"2026-04-07T09:41:33.648925Z","end":"2026-04-07T09:41:33.940834Z","steps":["trace[1028335786] 'range keys from in-memory index tree' (duration: 291.563804ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:34.097557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.999567ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-04-07T09:41:34.097859Z","caller":"traceutil/trace.go:171","msg":"trace[1423526786] linearizableReadLoop","detail":"{readStateIndex:1097; appliedIndex:1095; }","duration":"114.093693ms","start":"2026-04-07T09:41:33.983749Z","end":"2026-04-07T09:41:34.097843Z","steps":["trace[1423526786] 'read index received' (duration: 38.191µs)","trace[1423526786] 'applied index is now lower than readState.Index' (duration: 114.054552ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:41:34.097981Z","caller":"traceutil/trace.go:171","msg":"trace[58862150] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"152.719243ms","start":"2026-04-07T09:41:33.94525Z","end":"2026-04-07T09:41:34.09797Z","steps":["trace[58862150] 'process raft request' (duration: 152.403415ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:34.098237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.480973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T09:41:34.09831Z","caller":"traceutil/trace.go:171","msg":"trace[936144952] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1052; }","duration":"114.592617ms","start":"2026-04-07T09:41:33.9837Z","end":"2026-04-07T09:41:34.098293Z","steps":["trace[936144952] 'agreement among raft nodes before linearized reading' (duration: 114.461653ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:43.670757Z","caller":"traceutil/trace.go:171","msg":"trace[744954819] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"1.064982491s","start":"2026-04-07T09:41:42.605744Z","end":"2026-04-07T09:41:43.670726Z","steps":["trace[744954819] 'process raft request' (duration: 1.064794296s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:43.671051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:42.605718Z","time spent":"1.065239417s","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:41:43.673765Z","caller":"traceutil/trace.go:171","msg":"trace[469462866] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"985.915154ms","start":"2026-04-07T09:41:42.687833Z","end":"2026-04-07T09:41:43.673749Z","steps":["trace[469462866] 'process raft request' (duration: 985.718679ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:43.673832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:42.687808Z","time spent":"985.989346ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:41:43.67553Z","caller":"traceutil/trace.go:171","msg":"trace[768803451] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1126; }","duration":"138.589702ms","start":"2026-04-07T09:41:43.536911Z","end":"2026-04-07T09:41:43.675501Z","steps":["trace[768803451] 'read index received' (duration: 133.586149ms)","trace[768803451] 'applied index is now lower than readState.Index' (duration: 5.001993ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:43.675964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.022534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:43.676032Z","caller":"traceutil/trace.go:171","msg":"trace[1341492319] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"139.132097ms","start":"2026-04-07T09:41:43.536883Z","end":"2026-04-07T09:41:43.676015Z","steps":["trace[1341492319] 'agreement among raft nodes before linearized reading' (duration: 138.902931ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:50.873319Z","caller":"traceutil/trace.go:171","msg":"trace[176792126] transaction","detail":"{read_only:false; response_revision:1161; number_of_response:1; }","duration":"569.722556ms","start":"2026-04-07T09:41:50.30357Z","end":"2026-04-07T09:41:50.873292Z","steps":["trace[176792126] 'process raft request' (duration: 569.581562ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:50.873506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:50.303554Z","time spent":"569.877981ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:41:51.251906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.604455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:41:51.252081Z","caller":"traceutil/trace.go:171","msg":"trace[690921189] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1210; }","duration":"713.813625ms","start":"2026-04-07T09:41:50.538253Z","end":"2026-04-07T09:41:51.252067Z","steps":["trace[690921189] 'read index received' (duration: 334.909921ms)","trace[690921189] 'applied index is now lower than readState.Index' (duration: 378.902394ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:51.252123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.878676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:41:51.252144Z","caller":"traceutil/trace.go:171","msg":"trace[1033800366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1163; }","duration":"713.926698ms","start":"2026-04-07T09:41:50.538208Z","end":"2026-04-07T09:41:51.252135Z","steps":["trace[1033800366] 'agreement among raft nodes before linearized reading' (duration: 713.894277ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:41:51.252105Z","caller":"traceutil/trace.go:171","msg":"trace[131811594] transaction","detail":"{read_only:false; response_revision:1162; number_of_response:1; }","duration":"948.322452ms","start":"2026-04-07T09:41:50.303745Z","end":"2026-04-07T09:41:51.252067Z","steps":["trace[131811594] 'process raft request' (duration: 682.48521ms)","trace[131811594] 'compare' (duration: 265.445021ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:41:51.252167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:50.53819Z","time spent":"713.97221ms","remote":"127.0.0.1:39598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-07T09:41:51.252208Z","caller":"traceutil/trace.go:171","msg":"trace[32794843] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"946.046572ms","start":"2026-04-07T09:41:50.306135Z","end":"2026-04-07T09:41:51.252181Z","steps":["trace[32794843] 'process raft request' (duration: 945.846536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:41:51.252287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:50.303735Z","time spent":"948.450745ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:41:51.252326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:41:50.306127Z","time spent":"946.135934ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:42:03.929437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.999111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T09:42:03.929582Z","caller":"traceutil/trace.go:171","msg":"trace[806599932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1203; }","duration":"101.185736ms","start":"2026-04-07T09:42:03.828343Z","end":"2026-04-07T09:42:03.929528Z","steps":["trace[806599932] 'range keys from in-memory index tree' (duration: 100.777785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:03.929448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.679139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T09:42:03.92967Z","caller":"traceutil/trace.go:171","msg":"trace[127392671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1203; }","duration":"104.965626ms","start":"2026-04-07T09:42:03.824679Z","end":"2026-04-07T09:42:03.929645Z","steps":["trace[127392671] 'range keys from in-memory index tree' (duration: 104.412101ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:06.644196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.109929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:42:06.64429Z","caller":"traceutil/trace.go:171","msg":"trace[973438057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1219; }","duration":"108.247533ms","start":"2026-04-07T09:42:06.536029Z","end":"2026-04-07T09:42:06.644276Z","steps":["trace[973438057] 'range keys from in-memory index tree' (duration: 108.028778ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:06.644322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"705.705209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T09:42:06.644352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"704.433916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T09:42:06.644385Z","caller":"traceutil/trace.go:171","msg":"trace[226164675] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1219; }","duration":"704.491027ms","start":"2026-04-07T09:42:05.939885Z","end":"2026-04-07T09:42:06.644376Z","steps":["trace[226164675] 'range keys from in-memory index tree' (duration: 704.306062ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:06.64439Z","caller":"traceutil/trace.go:171","msg":"trace[1335632575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1219; }","duration":"705.815412ms","start":"2026-04-07T09:42:05.938555Z","end":"2026-04-07T09:42:06.64437Z","steps":["trace[1335632575] 'range keys from in-memory index tree' (duration: 705.528744ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:06.644421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:05.939877Z","time spent":"704.522608ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T09:42:06.644453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:05.938535Z","time spent":"705.901725ms","remote":"127.0.0.1:33994","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-04-07T09:42:06.86041Z","caller":"traceutil/trace.go:171","msg":"trace[1337218859] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"212.264904ms","start":"2026-04-07T09:42:06.648121Z","end":"2026-04-07T09:42:06.860386Z","steps":["trace[1337218859] 'process raft request' (duration: 212.062239ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:06.874582Z","caller":"traceutil/trace.go:171","msg":"trace[890683925] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"225.782154ms","start":"2026-04-07T09:42:06.648775Z","end":"2026-04-07T09:42:06.874558Z","steps":["trace[890683925] 'process raft request' (duration: 225.619009ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:08.03185Z","caller":"traceutil/trace.go:171","msg":"trace[1878853394] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"209.248464ms","start":"2026-04-07T09:42:07.822584Z","end":"2026-04-07T09:42:08.031832Z","steps":["trace[1878853394] 'process raft request' (duration: 209.139281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:08.792906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.605741ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:42:08.793404Z","caller":"traceutil/trace.go:171","msg":"trace[1984776199] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1225; }","duration":"309.113084ms","start":"2026-04-07T09:42:08.484275Z","end":"2026-04-07T09:42:08.793388Z","steps":["trace[1984776199] 'range keys from in-memory index tree' (duration: 308.59094ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:08.793089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"515.213535ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:42:08.793535Z","caller":"traceutil/trace.go:171","msg":"trace[856179904] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1278; }","duration":"343.951992ms","start":"2026-04-07T09:42:08.449564Z","end":"2026-04-07T09:42:08.793516Z","steps":["trace[856179904] 'read index received' (duration: 40.821µs)","trace[856179904] 'applied index is now lower than readState.Index' (duration: 343.908901ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:08.793646Z","caller":"traceutil/trace.go:171","msg":"trace[301756422] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"738.00491ms","start":"2026-04-07T09:42:08.055629Z","end":"2026-04-07T09:42:08.793634Z","steps":["trace[301756422] 'process raft request' (duration: 222.167148ms)","trace[301756422] 'compare' (duration: 514.744902ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:42:08.793718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:08.05561Z","time spent":"738.070222ms","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":757,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T09:42:08.794032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.462106ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.244\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T09:42:08.79407Z","caller":"traceutil/trace.go:171","msg":"trace[951272774] range","detail":"{range_begin:/registry/masterleases/199.204.45.244; range_end:; response_count:1; response_revision:1226; }","duration":"344.531428ms","start":"2026-04-07T09:42:08.449529Z","end":"2026-04-07T09:42:08.794061Z","steps":["trace[951272774] 'agreement among raft nodes before linearized reading' (duration: 344.374004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:08.794102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:08.449512Z","time spent":"344.582189ms","remote":"127.0.0.1:39614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.244\" "} {"level":"warn","ts":"2026-04-07T09:42:08.794243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.371965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T09:42:08.794287Z","caller":"traceutil/trace.go:171","msg":"trace[60600698] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1226; }","duration":"314.466727ms","start":"2026-04-07T09:42:08.479807Z","end":"2026-04-07T09:42:08.794274Z","steps":["trace[60600698] 'agreement among raft nodes before linearized reading' (duration: 314.333394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:08.794286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.916143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:42:08.794328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:08.479774Z","time spent":"314.54245ms","remote":"127.0.0.1:39656","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":115,"response size":29,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-04-07T09:42:08.79435Z","caller":"traceutil/trace.go:171","msg":"trace[848538586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1226; }","duration":"257.016197ms","start":"2026-04-07T09:42:08.537316Z","end":"2026-04-07T09:42:08.794332Z","steps":["trace[848538586] 'agreement among raft nodes before linearized reading' (duration: 256.894413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:08.794354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.963683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-04-07T09:42:08.794424Z","caller":"traceutil/trace.go:171","msg":"trace[1703470711] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1226; }","duration":"207.066266ms","start":"2026-04-07T09:42:08.587338Z","end":"2026-04-07T09:42:08.794405Z","steps":["trace[1703470711] 'agreement among raft nodes before linearized reading' (duration: 206.832929ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:09.08011Z","caller":"traceutil/trace.go:171","msg":"trace[944630739] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1279; }","duration":"216.336233ms","start":"2026-04-07T09:42:08.863754Z","end":"2026-04-07T09:42:09.08009Z","steps":["trace[944630739] 'read index received' (duration: 157.101095ms)","trace[944630739] 'applied index is now lower than readState.Index' (duration: 59.233898ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:09.080211Z","caller":"traceutil/trace.go:171","msg":"trace[1387460820] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"278.301034ms","start":"2026-04-07T09:42:08.801899Z","end":"2026-04-07T09:42:09.0802Z","steps":["trace[1387460820] 'process raft request' (duration: 278.133ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:09.080229Z","caller":"traceutil/trace.go:171","msg":"trace[308150106] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"278.596861ms","start":"2026-04-07T09:42:08.8016Z","end":"2026-04-07T09:42:09.080197Z","steps":["trace[308150106] 'process raft request' (duration: 278.309543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.080354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.581289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T09:42:09.08039Z","caller":"traceutil/trace.go:171","msg":"trace[164663021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1228; }","duration":"216.668471ms","start":"2026-04-07T09:42:08.863712Z","end":"2026-04-07T09:42:09.08038Z","steps":["trace[164663021] 'agreement among raft nodes before linearized reading' (duration: 216.497907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.112425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.584296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T09:42:09.112494Z","caller":"traceutil/trace.go:171","msg":"trace[696940401] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1229; }","duration":"119.696539ms","start":"2026-04-07T09:42:08.992781Z","end":"2026-04-07T09:42:09.112478Z","steps":["trace[696940401] 'agreement among raft nodes before linearized reading' (duration: 119.457153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.112807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.711202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T09:42:09.11285Z","caller":"traceutil/trace.go:171","msg":"trace[741025476] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1229; }","duration":"234.783275ms","start":"2026-04-07T09:42:08.878056Z","end":"2026-04-07T09:42:09.11284Z","steps":["trace[741025476] 'agreement among raft nodes before linearized reading' (duration: 234.63926ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:09.230481Z","caller":"traceutil/trace.go:171","msg":"trace[1233260629] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"113.187425ms","start":"2026-04-07T09:42:09.117273Z","end":"2026-04-07T09:42:09.23046Z","steps":["trace[1233260629] 'process raft request' (duration: 61.671752ms)","trace[1233260629] 'compare' (duration: 51.387249ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:09.230691Z","caller":"traceutil/trace.go:171","msg":"trace[1323022676] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"112.193099ms","start":"2026-04-07T09:42:09.118492Z","end":"2026-04-07T09:42:09.230685Z","steps":["trace[1323022676] 'process raft request' (duration: 111.943522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.230762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.235466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-04-07T09:42:09.230847Z","caller":"traceutil/trace.go:171","msg":"trace[362553159] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1233; }","duration":"116.364729ms","start":"2026-04-07T09:42:09.114465Z","end":"2026-04-07T09:42:09.230829Z","steps":["trace[362553159] 'agreement among raft nodes before linearized reading' (duration: 116.158684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.471778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.896751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:42:09.471865Z","caller":"traceutil/trace.go:171","msg":"trace[815528626] linearizableReadLoop","detail":"{readStateIndex:1288; appliedIndex:1287; }","duration":"239.200092ms","start":"2026-04-07T09:42:09.23265Z","end":"2026-04-07T09:42:09.471851Z","steps":["trace[815528626] 'read index received' (duration: 115.075446ms)","trace[815528626] 'applied index is now lower than readState.Index' (duration: 124.123496ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:09.471978Z","caller":"traceutil/trace.go:171","msg":"trace[1178845025] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"326.538458ms","start":"2026-04-07T09:42:09.145412Z","end":"2026-04-07T09:42:09.47195Z","steps":["trace[1178845025] 'process raft request' (duration: 202.400182ms)","trace[1178845025] 'compare' (duration: 123.786687ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:42:09.472019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.365857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-07T09:42:09.472044Z","caller":"traceutil/trace.go:171","msg":"trace[1527841145] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1234; }","duration":"239.428718ms","start":"2026-04-07T09:42:09.232608Z","end":"2026-04-07T09:42:09.472037Z","steps":["trace[1527841145] 'agreement among raft nodes before linearized reading' (duration: 239.311574ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.47209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.907971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T09:42:09.472117Z","caller":"traceutil/trace.go:171","msg":"trace[16559171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1234; }","duration":"114.960353ms","start":"2026-04-07T09:42:09.35715Z","end":"2026-04-07T09:42:09.47211Z","steps":["trace[16559171] 'agreement among raft nodes before linearized reading' (duration: 114.861701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.472103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:09.145386Z","time spent":"326.649922ms","remote":"127.0.0.1:34098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":797,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:42:09.884448Z","caller":"traceutil/trace.go:171","msg":"trace[77353717] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"408.550893ms","start":"2026-04-07T09:42:09.475879Z","end":"2026-04-07T09:42:09.88443Z","steps":["trace[77353717] 'process raft request' (duration: 330.135925ms)","trace[77353717] 'compare' (duration: 77.910945ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:09.884507Z","caller":"traceutil/trace.go:171","msg":"trace[1473862018] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"349.023428ms","start":"2026-04-07T09:42:09.535465Z","end":"2026-04-07T09:42:09.884488Z","steps":["trace[1473862018] 'read index received' (duration: 270.561278ms)","trace[1473862018] 'applied index is now lower than readState.Index' (duration: 78.4605ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:42:09.884554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:09.475858Z","time spent":"408.640745ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:42:09.885211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.752507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:42:09.885244Z","caller":"traceutil/trace.go:171","msg":"trace[96090156] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1237; }","duration":"349.8559ms","start":"2026-04-07T09:42:09.53538Z","end":"2026-04-07T09:42:09.885236Z","steps":["trace[96090156] 'agreement among raft nodes before linearized reading' (duration: 349.148771ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:09.885264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:09.535363Z","time spent":"349.89356ms","remote":"127.0.0.1:39598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:42:10.302081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.637659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:42:10.302178Z","caller":"traceutil/trace.go:171","msg":"trace[946499886] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1237; }","duration":"297.779413ms","start":"2026-04-07T09:42:10.004375Z","end":"2026-04-07T09:42:10.302155Z","steps":["trace[946499886] 'count revisions from in-memory index tree' (duration: 297.30823ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:10.469584Z","caller":"traceutil/trace.go:171","msg":"trace[1134036263] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"432.817959ms","start":"2026-04-07T09:42:10.036749Z","end":"2026-04-07T09:42:10.469567Z","steps":["trace[1134036263] 'process raft request' (duration: 432.705846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:10.469692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:10.03673Z","time spent":"432.905723ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:42:11.270688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.628583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:42:11.270766Z","caller":"traceutil/trace.go:171","msg":"trace[93694027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"733.761677ms","start":"2026-04-07T09:42:10.536985Z","end":"2026-04-07T09:42:11.270747Z","steps":["trace[93694027] 'range keys from in-memory index tree' (duration: 733.527711ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:11.270948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:10.536964Z","time spent":"733.831668ms","remote":"127.0.0.1:39598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:42:11.271114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.348039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T09:42:11.271174Z","caller":"traceutil/trace.go:171","msg":"trace[724527591] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1238; }","duration":"125.457501ms","start":"2026-04-07T09:42:11.145704Z","end":"2026-04-07T09:42:11.271161Z","steps":["trace[724527591] 'range keys from in-memory index tree' (duration: 125.185635ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:12.020033Z","caller":"traceutil/trace.go:171","msg":"trace[254425451] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"182.294955ms","start":"2026-04-07T09:42:11.837715Z","end":"2026-04-07T09:42:12.02001Z","steps":["trace[254425451] 'process raft request' (duration: 181.649278ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:12.023182Z","caller":"traceutil/trace.go:171","msg":"trace[924018069] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1299; }","duration":"134.863713ms","start":"2026-04-07T09:42:11.8883Z","end":"2026-04-07T09:42:12.023163Z","steps":["trace[924018069] 'read index received' (duration: 131.176594ms)","trace[924018069] 'applied index is now lower than readState.Index' (duration: 3.685969ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:42:12.023397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.084478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T09:42:12.023444Z","caller":"traceutil/trace.go:171","msg":"trace[1654335864] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1248; }","duration":"135.177221ms","start":"2026-04-07T09:42:11.888251Z","end":"2026-04-07T09:42:12.023428Z","steps":["trace[1654335864] 'agreement among raft nodes before linearized reading' (duration: 134.988886ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:12.023315Z","caller":"traceutil/trace.go:171","msg":"trace[1406596508] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"185.464491ms","start":"2026-04-07T09:42:11.837809Z","end":"2026-04-07T09:42:12.023273Z","steps":["trace[1406596508] 'process raft request' (duration: 185.181702ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:12.02381Z","caller":"traceutil/trace.go:171","msg":"trace[2008484203] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"183.5594ms","start":"2026-04-07T09:42:11.840235Z","end":"2026-04-07T09:42:12.023795Z","steps":["trace[2008484203] 'process raft request' (duration: 182.872591ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:19.469851Z","caller":"traceutil/trace.go:171","msg":"trace[1401496794] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"102.310055ms","start":"2026-04-07T09:42:19.367523Z","end":"2026-04-07T09:42:19.469833Z","steps":["trace[1401496794] 'process raft request' (duration: 94.5884ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:20.595677Z","caller":"traceutil/trace.go:171","msg":"trace[1022238911] linearizableReadLoop","detail":"{readStateIndex:1375; appliedIndex:1374; }","duration":"229.236186ms","start":"2026-04-07T09:42:20.366418Z","end":"2026-04-07T09:42:20.595654Z","steps":["trace[1022238911] 'read index received' (duration: 229.111783ms)","trace[1022238911] 'applied index is now lower than readState.Index' (duration: 123.013µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:20.595762Z","caller":"traceutil/trace.go:171","msg":"trace[792167247] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"407.71467ms","start":"2026-04-07T09:42:20.188015Z","end":"2026-04-07T09:42:20.595729Z","steps":["trace[792167247] 'process raft request' (duration: 407.454524ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:20.595921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:20.187989Z","time spent":"407.848985ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:42:20.595928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.471863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-07T09:42:20.59599Z","caller":"traceutil/trace.go:171","msg":"trace[998299336] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1319; }","duration":"229.594626ms","start":"2026-04-07T09:42:20.366378Z","end":"2026-04-07T09:42:20.595972Z","steps":["trace[998299336] 'agreement among raft nodes before linearized reading' (duration: 229.39273ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.740125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"925.77362ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T09:42:21.740302Z","caller":"traceutil/trace.go:171","msg":"trace[2073868885] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"1.139702539s","start":"2026-04-07T09:42:20.600584Z","end":"2026-04-07T09:42:21.740286Z","steps":["trace[2073868885] 'process raft request' (duration: 1.139627538s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.740359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:20.600538Z","time spent":"1.139793232s","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T09:42:21.740491Z","caller":"traceutil/trace.go:171","msg":"trace[493301003] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"1.144729294s","start":"2026-04-07T09:42:20.595745Z","end":"2026-04-07T09:42:21.740475Z","steps":["trace[493301003] 'read index received' (duration: 218.545332ms)","trace[493301003] 'applied index is now lower than readState.Index' (duration: 926.182432ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:21.740541Z","caller":"traceutil/trace.go:171","msg":"trace[233111723] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"1.220496653s","start":"2026-04-07T09:42:20.520006Z","end":"2026-04-07T09:42:21.740502Z","steps":["trace[233111723] 'process raft request' (duration: 294.27377ms)","trace[233111723] 'compare' (duration: 924.920778ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:42:21.740641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.203411767s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:42:21.740681Z","caller":"traceutil/trace.go:171","msg":"trace[927982655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"1.203479868s","start":"2026-04-07T09:42:20.537189Z","end":"2026-04-07T09:42:21.740669Z","steps":["trace[927982655] 'agreement among raft nodes before linearized reading' (duration: 1.203411626s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.740715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:20.537174Z","time spent":"1.20353321s","remote":"127.0.0.1:39598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T09:42:21.740715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:20.519982Z","time spent":"1.220644586s","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T09:42:21.740827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"866.532643ms","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-04-07T09:42:21.740858Z","caller":"traceutil/trace.go:171","msg":"trace[937092605] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:1321; }","duration":"866.609235ms","start":"2026-04-07T09:42:20.87424Z","end":"2026-04-07T09:42:21.740849Z","steps":["trace[937092605] 'agreement among raft nodes before linearized reading' (duration: 866.524292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.740882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:20.874215Z","time spent":"866.660116ms","remote":"127.0.0.1:34060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":70,"response size":29,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:42:21.740998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.757562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-04-07T09:42:21.741038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.36202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-07T09:42:21.741066Z","caller":"traceutil/trace.go:171","msg":"trace[655676949] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1321; }","duration":"345.486853ms","start":"2026-04-07T09:42:21.395571Z","end":"2026-04-07T09:42:21.741058Z","steps":["trace[655676949] 'agreement among raft nodes before linearized reading' (duration: 345.404371ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.74109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:21.39556Z","time spent":"345.524404ms","remote":"127.0.0.1:33994","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-04-07T09:42:21.74109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.335084734s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T09:42:21.741112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.568378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T09:42:21.741121Z","caller":"traceutil/trace.go:171","msg":"trace[101914381] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1321; }","duration":"1.335155456s","start":"2026-04-07T09:42:20.405957Z","end":"2026-04-07T09:42:21.741112Z","steps":["trace[101914381] 'agreement among raft nodes before linearized reading' (duration: 1.335103785s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.741121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.303731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-04-07T09:42:21.741149Z","caller":"traceutil/trace.go:171","msg":"trace[1202054024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"374.642181ms","start":"2026-04-07T09:42:21.366497Z","end":"2026-04-07T09:42:21.741139Z","steps":["trace[1202054024] 'agreement among raft nodes before linearized reading' (duration: 374.503406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.741159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:20.405935Z","time spent":"1.335210958s","remote":"127.0.0.1:44572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-04-07T09:42:21.741183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:21.366475Z","time spent":"374.702292ms","remote":"127.0.0.1:33994","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-04-07T09:42:21.741036Z","caller":"traceutil/trace.go:171","msg":"trace[1883834506] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1321; }","duration":"267.832964ms","start":"2026-04-07T09:42:21.473191Z","end":"2026-04-07T09:42:21.741024Z","steps":["trace[1883834506] 'agreement among raft nodes before linearized reading' (duration: 267.707261ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:21.741205Z","caller":"traceutil/trace.go:171","msg":"trace[1041766122] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1321; }","duration":"481.425485ms","start":"2026-04-07T09:42:21.259757Z","end":"2026-04-07T09:42:21.741183Z","steps":["trace[1041766122] 'agreement among raft nodes before linearized reading' (duration: 481.236219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T09:42:21.741246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T09:42:21.259738Z","time spent":"481.497706ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":546,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-07T09:42:21.944424Z","caller":"traceutil/trace.go:171","msg":"trace[88444467] transaction","detail":"{read_only:false; response_revision:1322; number_of_response:1; }","duration":"198.069637ms","start":"2026-04-07T09:42:21.746329Z","end":"2026-04-07T09:42:21.944398Z","steps":["trace[88444467] 'process raft request' (duration: 192.421287ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:21.954257Z","caller":"traceutil/trace.go:171","msg":"trace[1273316730] transaction","detail":"{read_only:false; response_revision:1323; number_of_response:1; }","duration":"207.496357ms","start":"2026-04-07T09:42:21.746746Z","end":"2026-04-07T09:42:21.954243Z","steps":["trace[1273316730] 'process raft request' (duration: 207.361734ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:21.9544Z","caller":"traceutil/trace.go:171","msg":"trace[825156775] transaction","detail":"{read_only:false; response_revision:1324; number_of_response:1; }","duration":"207.563769ms","start":"2026-04-07T09:42:21.74683Z","end":"2026-04-07T09:42:21.954394Z","steps":["trace[825156775] 'process raft request' (duration: 207.368374ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:21.95454Z","caller":"traceutil/trace.go:171","msg":"trace[448523856] linearizableReadLoop","detail":"{readStateIndex:1382; appliedIndex:1377; }","duration":"199.617127ms","start":"2026-04-07T09:42:21.754915Z","end":"2026-04-07T09:42:21.954532Z","steps":["trace[448523856] 'read index received' (duration: 183.832267ms)","trace[448523856] 'applied index is now lower than readState.Index' (duration: 15.78416ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:42:21.954593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.667299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T09:42:21.9546Z","caller":"traceutil/trace.go:171","msg":"trace[1320112881] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"206.494771ms","start":"2026-04-07T09:42:21.748093Z","end":"2026-04-07T09:42:21.954588Z","steps":["trace[1320112881] 'process raft request' (duration: 206.273755ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:21.954631Z","caller":"traceutil/trace.go:171","msg":"trace[1237390168] transaction","detail":"{read_only:false; response_revision:1326; number_of_response:1; }","duration":"204.24729ms","start":"2026-04-07T09:42:21.75038Z","end":"2026-04-07T09:42:21.954627Z","steps":["trace[1237390168] 'process raft request' (duration: 204.123907ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:21.954612Z","caller":"traceutil/trace.go:171","msg":"trace[1856474809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1326; }","duration":"199.71337ms","start":"2026-04-07T09:42:21.754893Z","end":"2026-04-07T09:42:21.954606Z","steps":["trace[1856474809] 'agreement among raft nodes before linearized reading' (duration: 199.669439ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:35.967275Z","caller":"traceutil/trace.go:171","msg":"trace[898589876] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"141.291124ms","start":"2026-04-07T09:42:35.825943Z","end":"2026-04-07T09:42:35.967234Z","steps":["trace[898589876] 'process raft request' (duration: 111.85039ms)","trace[898589876] 'compare' (duration: 29.295931ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:36.109062Z","caller":"traceutil/trace.go:171","msg":"trace[1141200448] transaction","detail":"{read_only:false; response_revision:1388; number_of_response:1; }","duration":"102.187402ms","start":"2026-04-07T09:42:36.006842Z","end":"2026-04-07T09:42:36.109029Z","steps":["trace[1141200448] 'process raft request' (duration: 63.395269ms)","trace[1141200448] 'compare' (duration: 38.627719ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T09:42:36.109223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.054194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T09:42:36.109484Z","caller":"traceutil/trace.go:171","msg":"trace[513353962] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1388; }","duration":"100.277441ms","start":"2026-04-07T09:42:36.009076Z","end":"2026-04-07T09:42:36.109353Z","steps":["trace[513353962] 'agreement among raft nodes before linearized reading' (duration: 99.960862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:36.276053Z","caller":"traceutil/trace.go:171","msg":"trace[611177169] transaction","detail":"{read_only:false; response_revision:1390; number_of_response:1; }","duration":"161.834111ms","start":"2026-04-07T09:42:36.114181Z","end":"2026-04-07T09:42:36.276015Z","steps":["trace[611177169] 'process raft request' (duration: 101.053291ms)","trace[611177169] 'compare' (duration: 60.649126ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T09:42:42.09427Z","caller":"traceutil/trace.go:171","msg":"trace[1850854962] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"103.083316ms","start":"2026-04-07T09:42:41.991165Z","end":"2026-04-07T09:42:42.094248Z","steps":["trace[1850854962] 'process raft request' (duration: 102.948873ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:46.276641Z","caller":"traceutil/trace.go:171","msg":"trace[989639132] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"102.747621ms","start":"2026-04-07T09:42:46.173855Z","end":"2026-04-07T09:42:46.276603Z","steps":["trace[989639132] 'process raft request' (duration: 92.805368ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:42:47.25509Z","caller":"traceutil/trace.go:171","msg":"trace[962751718] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"152.90324ms","start":"2026-04-07T09:42:47.102167Z","end":"2026-04-07T09:42:47.25507Z","steps":["trace[962751718] 'process raft request' (duration: 152.791318ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.02368Z","caller":"traceutil/trace.go:171","msg":"trace[637770448] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"100.613894ms","start":"2026-04-07T09:44:22.923031Z","end":"2026-04-07T09:44:23.023644Z","steps":["trace[637770448] 'process raft request' (duration: 95.205252ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T09:44:23.027409Z","caller":"traceutil/trace.go:171","msg":"trace[381738882] transaction","detail":"{read_only:false; response_revision:1877; number_of_response:1; }","duration":"103.367026ms","start":"2026-04-07T09:44:22.92397Z","end":"2026-04-07T09:44:23.027337Z","steps":["trace[381738882] 'process raft request' (duration: 103.207482ms)"],"step_count":1}