{"level":"warn","ts":"2026-05-19T18:27:50.357895Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T18:27:50.358034Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-05-19T18:27:50.358105Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-19T18:27:50.358116Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-19T18:27:50.358144Z","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-05-19T18:27:50.3588Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-05-19T18:27:50.358879Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-05-19T18:27:50.363779Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.591609ms"} {"level":"info","ts":"2026-05-19T18:27:50.369935Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-05-19T18:27:50.370051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T18:27:50.37009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-05-19T18:27:50.370194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T18:27:50.370209Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-05-19T18:27:50.370332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-05-19T18:27:50.38344Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T18:27:50.384892Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T18:27:50.385967Z","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-05-19T18:27:50.389927Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T18:27:50.390229Z","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-05-19T18:27:50.39036Z","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-05-19T18:27:50.390396Z","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-05-19T18:27:50.390261Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T18:27:50.392268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-05-19T18:27:50.392814Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-05-19T18:27:50.395137Z","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-05-19T18:27:50.395215Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-19T18:27:50.395264Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-05-19T18:27:50.39544Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T18:27:50.395484Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T18:27:51.073097Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T18:27:51.073168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T18:27:51.073244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-05-19T18:27:51.073282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-05-19T18:27:51.073295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-19T18:27:51.073312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-05-19T18:27:51.07336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-05-19T18:27:51.074355Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T18:27:51.074602Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:27:51.074632Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T18:27:51.074718Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:27:51.075056Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T18:27:51.075112Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T18:27:51.075869Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:27:51.075994Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:27:51.076036Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T18:27:51.077075Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-05-19T18:27:51.078163Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-19T18:27:56.820899Z","caller":"traceutil/trace.go:171","msg":"trace[816774804] transaction","detail":"{read_only:false; response_revision:303; number_of_response:1; }","duration":"115.159186ms","start":"2026-05-19T18:27:56.705707Z","end":"2026-05-19T18:27:56.820866Z","steps":["trace[816774804] 'process raft request' (duration: 114.991061ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:15.17283Z","caller":"traceutil/trace.go:171","msg":"trace[2147245938] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"124.567282ms","start":"2026-05-19T18:28:15.048229Z","end":"2026-05-19T18:28:15.172796Z","steps":["trace[2147245938] 'process raft request' (duration: 116.643745ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:21.814039Z","caller":"traceutil/trace.go:171","msg":"trace[1621714346] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"105.3981ms","start":"2026-05-19T18:28:21.708624Z","end":"2026-05-19T18:28:21.814022Z","steps":["trace[1621714346] 'process raft request' (duration: 105.182245ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:21.820329Z","caller":"traceutil/trace.go:171","msg":"trace[1216138843] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"108.594983ms","start":"2026-05-19T18:28:21.711707Z","end":"2026-05-19T18:28:21.820302Z","steps":["trace[1216138843] 'process raft request' (duration: 108.383118ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:21.82079Z","caller":"traceutil/trace.go:171","msg":"trace[1053120934] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"108.667226ms","start":"2026-05-19T18:28:21.712101Z","end":"2026-05-19T18:28:21.820768Z","steps":["trace[1053120934] 'process raft request' (duration: 108.150452ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:21.820964Z","caller":"traceutil/trace.go:171","msg":"trace[25001203] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"104.026654ms","start":"2026-05-19T18:28:21.716927Z","end":"2026-05-19T18:28:21.820954Z","steps":["trace[25001203] 'process raft request' (duration: 103.717356ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:22.728935Z","caller":"traceutil/trace.go:171","msg":"trace[1474941429] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"172.870126ms","start":"2026-05-19T18:28:22.556038Z","end":"2026-05-19T18:28:22.728908Z","steps":["trace[1474941429] 'process raft request' (duration: 133.152346ms)","trace[1474941429] 'compare' (duration: 39.456894ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:22.729006Z","caller":"traceutil/trace.go:171","msg":"trace[921696736] linearizableReadLoop","detail":"{readStateIndex:599; appliedIndex:598; }","duration":"129.504752ms","start":"2026-05-19T18:28:22.599492Z","end":"2026-05-19T18:28:22.728997Z","steps":["trace[921696736] 'read index received' (duration: 89.608587ms)","trace[921696736] 'applied index is now lower than readState.Index' (duration: 39.895455ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:28:22.729106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.612384ms","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-05-19T18:28:22.72915Z","caller":"traceutil/trace.go:171","msg":"trace[2010367559] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"129.705586ms","start":"2026-05-19T18:28:22.59944Z","end":"2026-05-19T18:28:22.729145Z","steps":["trace[2010367559] 'agreement among raft nodes before linearized reading' (duration: 129.586013ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:23.551635Z","caller":"traceutil/trace.go:171","msg":"trace[1391999115] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"200.134741ms","start":"2026-05-19T18:28:23.351477Z","end":"2026-05-19T18:28:23.551612Z","steps":["trace[1391999115] 'process raft request' (duration: 188.719402ms)","trace[1391999115] 'compare' (duration: 11.312376ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:23.556259Z","caller":"traceutil/trace.go:171","msg":"trace[1117010453] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"194.401601ms","start":"2026-05-19T18:28:23.361475Z","end":"2026-05-19T18:28:23.555877Z","steps":["trace[1117010453] 'process raft request' (duration: 194.179835ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:23.561867Z","caller":"traceutil/trace.go:171","msg":"trace[1703345846] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:622; }","duration":"190.91157ms","start":"2026-05-19T18:28:23.3709Z","end":"2026-05-19T18:28:23.561812Z","steps":["trace[1703345846] 'read index received' (duration: 169.477888ms)","trace[1703345846] 'applied index is now lower than readState.Index' (duration: 21.432612ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:23.562103Z","caller":"traceutil/trace.go:171","msg":"trace[1180155307] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"198.224012ms","start":"2026-05-19T18:28:23.363777Z","end":"2026-05-19T18:28:23.562001Z","steps":["trace[1180155307] 'process raft request' (duration: 196.199738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:23.564386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.469387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:31126"} {"level":"info","ts":"2026-05-19T18:28:23.564519Z","caller":"traceutil/trace.go:171","msg":"trace[96899763] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/udproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:607; }","duration":"193.699533ms","start":"2026-05-19T18:28:23.370804Z","end":"2026-05-19T18:28:23.564484Z","steps":["trace[96899763] 'agreement among raft nodes before linearized reading' (duration: 191.134186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:24.342245Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500058852,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:28:24.842618Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500058852,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:28:25.043901Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.210845562s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T18:28:25.044255Z","caller":"traceutil/trace.go:171","msg":"trace[1959050695] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.211262162s","start":"2026-05-19T18:28:23.832965Z","end":"2026-05-19T18:28:25.044227Z","steps":["trace[1959050695] 'process raft request' (duration: 1.211114369s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:23.832948Z","time spent":"1.211365364s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4068,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:25.07645Z","caller":"traceutil/trace.go:171","msg":"trace[338552046] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:634; }","duration":"1.234476541s","start":"2026-05-19T18:28:23.841952Z","end":"2026-05-19T18:28:25.076428Z","steps":["trace[338552046] 'read index received' (duration: 1.202813082s)","trace[338552046] 'applied index is now lower than readState.Index' (duration: 31.662458ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:25.076505Z","caller":"traceutil/trace.go:171","msg":"trace[134614381] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"968.360861ms","start":"2026-05-19T18:28:24.108125Z","end":"2026-05-19T18:28:25.076486Z","steps":["trace[134614381] 'process raft request' (duration: 968.234268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.076567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.10809Z","time spent":"968.442073ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:28:25.07658Z","caller":"traceutil/trace.go:171","msg":"trace[569687806] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.165132184s","start":"2026-05-19T18:28:23.911393Z","end":"2026-05-19T18:28:25.076525Z","steps":["trace[569687806] 'process raft request' (duration: 1.164883528s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.076691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.234725357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:208485"} {"level":"warn","ts":"2026-05-19T18:28:25.076735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:23.911362Z","time spent":"1.165301889s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:28:25.076752Z","caller":"traceutil/trace.go:171","msg":"trace[1692719368] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:617; }","duration":"1.234815169s","start":"2026-05-19T18:28:23.841919Z","end":"2026-05-19T18:28:25.076734Z","steps":["trace[1692719368] 'agreement among raft nodes before linearized reading' (duration: 1.234595473s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.0768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:23.841901Z","time spent":"1.234889351s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":208507,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/securitypolicies.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-05-19T18:28:25.076999Z","caller":"traceutil/trace.go:171","msg":"trace[451896849] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"768.071366ms","start":"2026-05-19T18:28:24.308898Z","end":"2026-05-19T18:28:25.076969Z","steps":["trace[451896849] 'process raft request' (duration: 767.495131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.077084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.308879Z","time spent":"768.185348ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:28:25.540371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.195553ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:28:25.54054Z","caller":"traceutil/trace.go:171","msg":"trace[95375065] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"490.406162ms","start":"2026-05-19T18:28:25.050109Z","end":"2026-05-19T18:28:25.540515Z","steps":["trace[95375065] 'process raft request' (duration: 137.780538ms)","trace[95375065] 'compare' (duration: 352.08734ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:25.540578Z","caller":"traceutil/trace.go:171","msg":"trace[1521889533] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"428.644985ms","start":"2026-05-19T18:28:25.111921Z","end":"2026-05-19T18:28:25.540566Z","steps":["trace[1521889533] 'process raft request' (duration: 428.567684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.540663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.05009Z","time spent":"490.521405ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:25.540774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.111906Z","time spent":"428.763668ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24220,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:25.540957Z","caller":"traceutil/trace.go:171","msg":"trace[925497745] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"464.326051ms","start":"2026-05-19T18:28:25.076498Z","end":"2026-05-19T18:28:25.540824Z","steps":["trace[925497745] 'read index received' (duration: 111.396728ms)","trace[925497745] 'applied index is now lower than readState.Index' (duration: 352.924613ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:28:25.541134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"616.839554ms","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-05-19T18:28:25.541178Z","caller":"traceutil/trace.go:171","msg":"trace[2095252908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:619; }","duration":"616.910396ms","start":"2026-05-19T18:28:24.924252Z","end":"2026-05-19T18:28:25.541162Z","steps":["trace[2095252908] 'agreement among raft nodes before linearized reading' (duration: 616.780903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.541211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.569848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-05-19T18:28:25.541263Z","caller":"traceutil/trace.go:171","msg":"trace[52207360] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:619; }","duration":"634.66013ms","start":"2026-05-19T18:28:24.90659Z","end":"2026-05-19T18:28:25.54125Z","steps":["trace[52207360] 'agreement among raft nodes before linearized reading' (duration: 634.503637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.541296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.190491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T18:28:25.541302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.906573Z","time spent":"634.721602ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4202,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"info","ts":"2026-05-19T18:28:25.541324Z","caller":"traceutil/trace.go:171","msg":"trace[832430794] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"791.242503ms","start":"2026-05-19T18:28:24.750073Z","end":"2026-05-19T18:28:25.541315Z","steps":["trace[832430794] 'agreement among raft nodes before linearized reading' (duration: 791.167321ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.541355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.750052Z","time spent":"791.297054ms","remote":"127.0.0.1:57096","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-05-19T18:28:25.54122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.924227Z","time spent":"616.985268ms","remote":"127.0.0.1:57096","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-05-19T18:28:25.541602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.035427786s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:28:25.541696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.211620522s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T18:28:25.541732Z","caller":"traceutil/trace.go:171","msg":"trace[354424606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"1.211690714s","start":"2026-05-19T18:28:24.330032Z","end":"2026-05-19T18:28:25.541723Z","steps":["trace[354424606] 'agreement among raft nodes before linearized reading' (duration: 1.211603882s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.541764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.330016Z","time spent":"1.211742275s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T18:28:25.541823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.562337026s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:28:25.541876Z","caller":"traceutil/trace.go:171","msg":"trace[521796493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"1.562436559s","start":"2026-05-19T18:28:23.979426Z","end":"2026-05-19T18:28:25.541863Z","steps":["trace[521796493] 'agreement among raft nodes before linearized reading' (duration: 1.562365397s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.541914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:23.979408Z","time spent":"1.562496061s","remote":"127.0.0.1:56794","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-05-19T18:28:25.541921Z","caller":"traceutil/trace.go:171","msg":"trace[1954770360] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:619; }","duration":"1.035579351s","start":"2026-05-19T18:28:24.506124Z","end":"2026-05-19T18:28:25.541703Z","steps":["trace[1954770360] 'agreement among raft nodes before linearized reading' (duration: 1.035025346s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.541007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"835.159933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:28:25.542072Z","caller":"traceutil/trace.go:171","msg":"trace[125696517] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:619; }","duration":"836.251321ms","start":"2026-05-19T18:28:24.705804Z","end":"2026-05-19T18:28:25.542055Z","steps":["trace[125696517] 'agreement among raft nodes before linearized reading' (duration: 835.154823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.541615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.428555823s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T18:28:25.55475Z","caller":"traceutil/trace.go:171","msg":"trace[1328635244] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:619; }","duration":"1.441717618s","start":"2026-05-19T18:28:24.113019Z","end":"2026-05-19T18:28:25.554737Z","steps":["trace[1328635244] 'agreement among raft nodes before linearized reading' (duration: 1.428557624s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.554811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.113003Z","time spent":"1.441788791s","remote":"127.0.0.1:56858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-05-19T18:28:25.542081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.506083Z","time spent":"1.03595038s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-19T18:28:25.542396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:24.705784Z","time spent":"836.59684ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-19T18:28:25.996645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.168512ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:28:25.996744Z","caller":"traceutil/trace.go:171","msg":"trace[445414215] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"455.611762ms","start":"2026-05-19T18:28:25.541117Z","end":"2026-05-19T18:28:25.996728Z","steps":["trace[445414215] 'read index received' (duration: 252.313437ms)","trace[445414215] 'applied index is now lower than readState.Index' (duration: 203.297335ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:25.997024Z","caller":"traceutil/trace.go:171","msg":"trace[230254421] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"488.088692ms","start":"2026-05-19T18:28:25.50892Z","end":"2026-05-19T18:28:25.997008Z","steps":["trace[230254421] 'process raft request' (duration: 284.49448ms)","trace[230254421] 'compare' (duration: 203.041508ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:28:25.997108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.508885Z","time spent":"488.185005ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:28:25.997488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"691.491111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-05-19T18:28:25.997546Z","caller":"traceutil/trace.go:171","msg":"trace[906844224] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"691.550972ms","start":"2026-05-19T18:28:25.305975Z","end":"2026-05-19T18:28:25.997526Z","steps":["trace[906844224] 'agreement among raft nodes before linearized reading' (duration: 691.259595ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.997591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.305907Z","time spent":"691.672294ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4105,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-05-19T18:28:25.997604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"816.094153ms","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-05-19T18:28:25.997654Z","caller":"traceutil/trace.go:171","msg":"trace[815053911] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"816.177315ms","start":"2026-05-19T18:28:25.181462Z","end":"2026-05-19T18:28:25.997639Z","steps":["trace[815053911] 'agreement among raft nodes before linearized reading' (duration: 816.028751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.99771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.18144Z","time spent":"816.257967ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-19T18:28:25.997866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.204835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-05-19T18:28:25.997926Z","caller":"traceutil/trace.go:171","msg":"trace[595651907] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"892.288359ms","start":"2026-05-19T18:28:25.105623Z","end":"2026-05-19T18:28:25.997912Z","steps":["trace[595651907] 'agreement among raft nodes before linearized reading' (duration: 892.149174ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.997971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.105609Z","time spent":"892.34978ms","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9342,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-05-19T18:28:25.998087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.412427ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-19T18:28:25.998175Z","caller":"traceutil/trace.go:171","msg":"trace[2014455188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"757.53226ms","start":"2026-05-19T18:28:25.240627Z","end":"2026-05-19T18:28:25.998159Z","steps":["trace[2014455188] 'agreement among raft nodes before linearized reading' (duration: 757.263062ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:25.99823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.24061Z","time spent":"757.606931ms","remote":"127.0.0.1:57096","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-05-19T18:28:26.497039Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500058869,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:28:26.997939Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500058869,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:28:27.322792Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.529465107s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T18:28:27.33128Z","caller":"traceutil/trace.go:171","msg":"trace[622895261] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.778062168s","start":"2026-05-19T18:28:25.553193Z","end":"2026-05-19T18:28:27.331255Z","steps":["trace[622895261] 'process raft request' (duration: 1.76975624s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:27.331384Z","caller":"traceutil/trace.go:171","msg":"trace[1849969246] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"1.777605216s","start":"2026-05-19T18:28:25.55377Z","end":"2026-05-19T18:28:27.331375Z","steps":["trace[1849969246] 'process raft request' (duration: 1.777462633s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:27.331428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.553176Z","time spent":"1.778185541s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:27.331501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.553764Z","time spent":"1.777664078s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5153,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:27.331289Z","caller":"traceutil/trace.go:171","msg":"trace[1366719396] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"1.777997007s","start":"2026-05-19T18:28:25.55327Z","end":"2026-05-19T18:28:27.331267Z","steps":["trace[1366719396] 'process raft request' (duration: 1.777907824s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:27.331633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.553265Z","time spent":"1.778339386s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4318,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:27.331664Z","caller":"traceutil/trace.go:171","msg":"trace[1813815544] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"1.774961298s","start":"2026-05-19T18:28:25.556685Z","end":"2026-05-19T18:28:27.331646Z","steps":["trace[1813815544] 'process raft request' (duration: 1.774819163s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:27.331782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.556676Z","time spent":"1.77505342s","remote":"127.0.0.1:57096","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-05-19T18:28:27.331868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.555633Z","time spent":"1.7762334s","remote":"127.0.0.1:56858","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-19T18:28:27.334599Z","caller":"traceutil/trace.go:171","msg":"trace[1293669319] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.777685168s","start":"2026-05-19T18:28:25.556881Z","end":"2026-05-19T18:28:27.334566Z","steps":["trace[1293669319] 'process raft request' (duration: 1.774738271s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:27.334715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.556872Z","time spent":"1.77778257s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:27.551393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.998265314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-19T18:28:27.551484Z","caller":"traceutil/trace.go:171","msg":"trace[544535237] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.998396759s","start":"2026-05-19T18:28:25.553066Z","end":"2026-05-19T18:28:27.551463Z","steps":["trace[544535237] 'agreement among raft nodes before linearized reading' (duration: 1.998285655s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:27.551611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.553055Z","time spent":"1.998541792s","remote":"127.0.0.1:56808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/19 18:28:27 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-19T18:28:28.403798Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.074770298s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T18:28:28.404438Z","caller":"traceutil/trace.go:171","msg":"trace[231270128] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"2.401421024s","start":"2026-05-19T18:28:26.00298Z","end":"2026-05-19T18:28:28.404402Z","steps":["trace[231270128] 'process raft request' (duration: 2.401058884s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.404603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.002961Z","time spent":"2.401557257s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:28.404608Z","caller":"traceutil/trace.go:171","msg":"trace[1785040699] linearizableReadLoop","detail":"{readStateIndex:652; appliedIndex:640; }","duration":"2.40774602s","start":"2026-05-19T18:28:25.996773Z","end":"2026-05-19T18:28:28.404519Z","steps":["trace[1785040699] 'read index received' (duration: 1.326245835s)","trace[1785040699] 'applied index is now lower than readState.Index' (duration: 1.081499125s)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:28.404728Z","caller":"traceutil/trace.go:171","msg":"trace[459238861] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"2.236702681s","start":"2026-05-19T18:28:26.168012Z","end":"2026-05-19T18:28:28.404715Z","steps":["trace[459238861] 'process raft request' (duration: 2.2362576s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:28.40481Z","caller":"traceutil/trace.go:171","msg":"trace[1511357013] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"2.401593918s","start":"2026-05-19T18:28:26.003184Z","end":"2026-05-19T18:28:28.404778Z","steps":["trace[1511357013] 'process raft request' (duration: 2.400984623s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.404841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.167988Z","time spent":"2.236781632s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:28:28.404924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.003175Z","time spent":"2.401690571s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:28.404997Z","caller":"traceutil/trace.go:171","msg":"trace[695761248] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"1.663877957s","start":"2026-05-19T18:28:26.741106Z","end":"2026-05-19T18:28:28.404984Z","steps":["trace[695761248] 'process raft request' (duration: 1.663375414s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.405076Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.741085Z","time spent":"1.663945519s","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4558,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:28.405135Z","caller":"traceutil/trace.go:171","msg":"trace[561717285] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"2.067239132s","start":"2026-05-19T18:28:26.337883Z","end":"2026-05-19T18:28:28.405123Z","steps":["trace[561717285] 'process raft request' (duration: 2.066520373s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:28.405136Z","caller":"traceutil/trace.go:171","msg":"trace[793881103] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"2.190230774s","start":"2026-05-19T18:28:26.214889Z","end":"2026-05-19T18:28:28.40512Z","steps":["trace[793881103] 'process raft request' (duration: 2.189450643s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.405194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.337862Z","time spent":"2.067302614s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187455,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:28:28.405215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.214868Z","time spent":"2.190305345s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:28.405383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.49938216s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-05-19T18:28:28.405429Z","caller":"traceutil/trace.go:171","msg":"trace[1203764822] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:631; }","duration":"2.499428091s","start":"2026-05-19T18:28:25.905988Z","end":"2026-05-19T18:28:28.405416Z","steps":["trace[1203764822] 'agreement among raft nodes before linearized reading' (duration: 2.499250757s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.405448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.699929292s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"warn","ts":"2026-05-19T18:28:28.405466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.905902Z","time spent":"2.499556364s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4355,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-05-19T18:28:28.40549Z","caller":"traceutil/trace.go:171","msg":"trace[1047734699] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:631; }","duration":"2.699970273s","start":"2026-05-19T18:28:25.705508Z","end":"2026-05-19T18:28:28.405479Z","steps":["trace[1047734699] 'agreement among raft nodes before linearized reading' (duration: 2.69986686s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.405519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:25.705469Z","time spent":"2.700043213s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5608,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"info","ts":"2026-05-19T18:28:28.426587Z","caller":"traceutil/trace.go:171","msg":"trace[1129616717] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"872.887541ms","start":"2026-05-19T18:28:27.553682Z","end":"2026-05-19T18:28:28.42657Z","steps":["trace[1129616717] 'process raft request' (duration: 872.85143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.42682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:27.553659Z","time spent":"872.991024ms","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:28:28.426997Z","caller":"traceutil/trace.go:171","msg":"trace[929346187] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"1.078338801s","start":"2026-05-19T18:28:27.34865Z","end":"2026-05-19T18:28:28.426989Z","steps":["trace[929346187] 'process raft request' (duration: 1.077843018s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.427006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.913214068s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5168"} {"level":"warn","ts":"2026-05-19T18:28:28.427053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:27.348634Z","time spent":"1.078388702s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":24229,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:28.427085Z","caller":"traceutil/trace.go:171","msg":"trace[1933776908] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"1.913280409s","start":"2026-05-19T18:28:26.513749Z","end":"2026-05-19T18:28:28.42703Z","steps":["trace[1933776908] 'agreement among raft nodes before linearized reading' (duration: 1.913106075s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.42721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.513731Z","time spent":"1.913424424s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5190,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"info","ts":"2026-05-19T18:28:28.427258Z","caller":"traceutil/trace.go:171","msg":"trace[1514044413] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"1.088219701s","start":"2026-05-19T18:28:27.339032Z","end":"2026-05-19T18:28:28.427252Z","steps":["trace[1514044413] 'process raft request' (duration: 1.087221024s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.427305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:27.339014Z","time spent":"1.088269073s","remote":"127.0.0.1:56858","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:28.427505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.453431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:28:28.427542Z","caller":"traceutil/trace.go:171","msg":"trace[1698224535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"869.490892ms","start":"2026-05-19T18:28:27.558042Z","end":"2026-05-19T18:28:28.427533Z","steps":["trace[1698224535] 'agreement among raft nodes before linearized reading' (duration: 869.438971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.427657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:27.558004Z","time spent":"869.641986ms","remote":"127.0.0.1:56794","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-05-19T18:28:28.427757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.265535244s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:28:28.427789Z","caller":"traceutil/trace.go:171","msg":"trace[703753200] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/envoy-gateway; range_end:; response_count:0; response_revision:635; }","duration":"1.265584345s","start":"2026-05-19T18:28:27.162197Z","end":"2026-05-19T18:28:28.427781Z","steps":["trace[703753200] 'agreement among raft nodes before linearized reading' (duration: 1.265535414s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.427791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.721218359s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13220"} {"level":"warn","ts":"2026-05-19T18:28:28.427897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.322092516s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:9358"} {"level":"info","ts":"2026-05-19T18:28:28.427917Z","caller":"traceutil/trace.go:171","msg":"trace[1412893694] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"1.721340373s","start":"2026-05-19T18:28:26.706513Z","end":"2026-05-19T18:28:28.427853Z","steps":["trace[1412893694] 'agreement among raft nodes before linearized reading' (duration: 1.721169099s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.427967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.706495Z","time spent":"1.721460566s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13242,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-05-19T18:28:28.427825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:27.162183Z","time spent":"1.265625116s","remote":"127.0.0.1:57024","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":27,"request content":"key:\"/registry/serviceaccounts/envoy-gateway-system/envoy-gateway\" "} {"level":"info","ts":"2026-05-19T18:28:28.427929Z","caller":"traceutil/trace.go:171","msg":"trace[1480673075] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"1.322160078s","start":"2026-05-19T18:28:27.10576Z","end":"2026-05-19T18:28:28.42792Z","steps":["trace[1480673075] 'agreement among raft nodes before linearized reading' (duration: 1.322085016s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.429171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:27.105735Z","time spent":"1.32342631s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":9380,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-05-19T18:28:28.43012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.52193348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-05-19T18:28:28.43023Z","caller":"traceutil/trace.go:171","msg":"trace[2016269406] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:635; }","duration":"1.524540558s","start":"2026-05-19T18:28:26.905662Z","end":"2026-05-19T18:28:28.430203Z","steps":["trace[2016269406] 'agreement among raft nodes before linearized reading' (duration: 1.521835337s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.43032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:26.905647Z","time spent":"1.524627841s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24266,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"info","ts":"2026-05-19T18:28:28.432273Z","caller":"traceutil/trace.go:171","msg":"trace[1491917204] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"1.080418086s","start":"2026-05-19T18:28:27.346553Z","end":"2026-05-19T18:28:28.426971Z","steps":["trace[1491917204] 'process raft request' (duration: 1.079873831s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:28.432467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:27.346536Z","time spent":"1.085795467s","remote":"127.0.0.1:56882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13205,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:32.680302Z","caller":"traceutil/trace.go:171","msg":"trace[1625154178] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"250.017168ms","start":"2026-05-19T18:28:32.430262Z","end":"2026-05-19T18:28:32.680279Z","steps":["trace[1625154178] 'read index received' (duration: 249.241588ms)","trace[1625154178] 'applied index is now lower than readState.Index' (duration: 774.69µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:32.680391Z","caller":"traceutil/trace.go:171","msg":"trace[1837428053] transaction","detail":"{read_only:false; response_revision:672; number_of_response:1; }","duration":"293.270111ms","start":"2026-05-19T18:28:32.387089Z","end":"2026-05-19T18:28:32.680359Z","steps":["trace[1837428053] 'process raft request' (duration: 292.695506ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:32.68053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.168503ms","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-05-19T18:28:32.680567Z","caller":"traceutil/trace.go:171","msg":"trace[37091275] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:672; }","duration":"250.283846ms","start":"2026-05-19T18:28:32.430271Z","end":"2026-05-19T18:28:32.680554Z","steps":["trace[37091275] 'agreement among raft nodes before linearized reading' (duration: 250.146893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:32.680698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.406639ms","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-05-19T18:28:32.680782Z","caller":"traceutil/trace.go:171","msg":"trace[265282020] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:672; }","duration":"250.530002ms","start":"2026-05-19T18:28:32.43023Z","end":"2026-05-19T18:28:32.68076Z","steps":["trace[265282020] 'agreement among raft nodes before linearized reading' (duration: 250.191154ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:32.885765Z","caller":"traceutil/trace.go:171","msg":"trace[671395961] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"146.484256ms","start":"2026-05-19T18:28:32.739247Z","end":"2026-05-19T18:28:32.885731Z","steps":["trace[671395961] 'process raft request' (duration: 146.322402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:33.45837Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500059061,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T18:28:33.670794Z","caller":"traceutil/trace.go:171","msg":"trace[1178590125] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:697; }","duration":"713.089883ms","start":"2026-05-19T18:28:32.957671Z","end":"2026-05-19T18:28:33.670761Z","steps":["trace[1178590125] 'read index received' (duration: 703.986834ms)","trace[1178590125] 'applied index is now lower than readState.Index' (duration: 9.101699ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:33.670834Z","caller":"traceutil/trace.go:171","msg":"trace[1951107267] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"763.616526ms","start":"2026-05-19T18:28:32.907196Z","end":"2026-05-19T18:28:33.670813Z","steps":["trace[1951107267] 'process raft request' (duration: 754.533128ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:33.670962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:32.907171Z","time spent":"763.715929ms","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:28:33.67109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.404752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-p5c7v\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-19T18:28:33.671142Z","caller":"traceutil/trace.go:171","msg":"trace[1674513048] range","detail":"{range_begin:/registry/pods/kube-system/cilium-p5c7v; range_end:; response_count:1; response_revision:676; }","duration":"713.500875ms","start":"2026-05-19T18:28:32.957626Z","end":"2026-05-19T18:28:33.671127Z","steps":["trace[1674513048] 'agreement among raft nodes before linearized reading' (duration: 713.281298ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:33.671092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"689.426404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:28:33.671185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:32.957603Z","time spent":"713.572246ms","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-p5c7v\" "} {"level":"info","ts":"2026-05-19T18:28:33.671232Z","caller":"traceutil/trace.go:171","msg":"trace[1481937480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:676; }","duration":"689.574938ms","start":"2026-05-19T18:28:32.981609Z","end":"2026-05-19T18:28:33.671184Z","steps":["trace[1481937480] 'agreement among raft nodes before linearized reading' (duration: 689.358753ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:33.671312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:32.981595Z","time spent":"689.681581ms","remote":"127.0.0.1:56794","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-05-19T18:28:33.671384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.715143ms","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-05-19T18:28:33.67144Z","caller":"traceutil/trace.go:171","msg":"trace[245401786] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:676; }","duration":"308.800415ms","start":"2026-05-19T18:28:33.362625Z","end":"2026-05-19T18:28:33.671425Z","steps":["trace[245401786] 'agreement among raft nodes before linearized reading' (duration: 308.664642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:33.671488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.362608Z","time spent":"308.868497ms","remote":"127.0.0.1:57096","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-05-19T18:28:33.671375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.376358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T18:28:33.671619Z","caller":"traceutil/trace.go:171","msg":"trace[1211186272] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:676; }","duration":"307.720747ms","start":"2026-05-19T18:28:33.363884Z","end":"2026-05-19T18:28:33.671604Z","steps":["trace[1211186272] 'agreement among raft nodes before linearized reading' (duration: 307.128372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:33.671683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.66196ms","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-05-19T18:28:33.671769Z","caller":"traceutil/trace.go:171","msg":"trace[46263546] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:676; }","duration":"306.800123ms","start":"2026-05-19T18:28:33.364952Z","end":"2026-05-19T18:28:33.671752Z","steps":["trace[46263546] 'agreement among raft nodes before linearized reading' (duration: 306.462064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:33.671855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.364944Z","time spent":"306.894105ms","remote":"127.0.0.1:57096","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-05-19T18:28:33.671693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.363865Z","time spent":"307.81477ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T18:28:34.613886Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500059065,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:28:35.114548Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500059065,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:28:35.522967Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.552442395s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-19T18:28:36.485777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.675664473s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:28:36.48607Z","caller":"traceutil/trace.go:171","msg":"trace[1879962160] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"2.808585395s","start":"2026-05-19T18:28:33.67745Z","end":"2026-05-19T18:28:36.486035Z","steps":["trace[1879962160] 'process raft request' (duration: 2.80844118s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:36.486143Z","caller":"traceutil/trace.go:171","msg":"trace[933853305] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"2.808486032s","start":"2026-05-19T18:28:33.677633Z","end":"2026-05-19T18:28:36.486119Z","steps":["trace[933853305] 'process raft request' (duration: 2.808342798s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.486232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.677442Z","time spent":"2.808711088s","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:28:36.486177Z","caller":"traceutil/trace.go:171","msg":"trace[1728116442] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"2.808868681s","start":"2026-05-19T18:28:33.677266Z","end":"2026-05-19T18:28:36.486135Z","steps":["trace[1728116442] 'process raft request' (duration: 131.976746ms)","trace[1728116442] 'compare' (duration: 2.674206515s)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:28:36.486342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.677627Z","time spent":"2.808567844s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:36.486424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.677257Z","time spent":"2.809089297s","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:28:36.486524Z","caller":"traceutil/trace.go:171","msg":"trace[612843330] transaction","detail":"{read_only:false; response_revision:681; number_of_response:1; }","duration":"2.808837881s","start":"2026-05-19T18:28:33.677678Z","end":"2026-05-19T18:28:36.486516Z","steps":["trace[612843330] 'process raft request' (duration: 2.808337028s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.486573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.677674Z","time spent":"2.808875402s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:36.48656Z","caller":"traceutil/trace.go:171","msg":"trace[35147594] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"2.80765361s","start":"2026-05-19T18:28:33.678866Z","end":"2026-05-19T18:28:36.48652Z","steps":["trace[35147594] 'process raft request' (duration: 2.807209769s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:36.486644Z","caller":"traceutil/trace.go:171","msg":"trace[1416839391] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"2.80800503s","start":"2026-05-19T18:28:33.678622Z","end":"2026-05-19T18:28:36.486627Z","steps":["trace[1416839391] 'process raft request' (duration: 2.807419195s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.486686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.678857Z","time spent":"2.807758762s","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:36.486742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.678614Z","time spent":"2.808073491s","remote":"127.0.0.1:57064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:36.487044Z","caller":"traceutil/trace.go:171","msg":"trace[1216246038] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:699; }","duration":"2.373232672s","start":"2026-05-19T18:28:34.113794Z","end":"2026-05-19T18:28:36.487027Z","steps":["trace[1216246038] 'read index received' (duration: 1.409415369s)","trace[1216246038] 'applied index is now lower than readState.Index' (duration: 963.816153ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:36.48709Z","caller":"traceutil/trace.go:171","msg":"trace[1711377743] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"2.803218764s","start":"2026-05-19T18:28:33.683861Z","end":"2026-05-19T18:28:36.48708Z","steps":["trace[1711377743] 'process raft request' (duration: 2.802566227s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:36.487101Z","caller":"traceutil/trace.go:171","msg":"trace[939168870] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"2.51669563s","start":"2026-05-19T18:28:33.970384Z","end":"2026-05-19T18:28:36.48708Z","steps":["trace[939168870] 'process raft request' (duration: 2.516545266s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.487134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.68384Z","time spent":"2.803271275s","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:36.48719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:33.970361Z","time spent":"2.516784392s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:36.487263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.789063614s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-05-19T18:28:36.487267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.373477179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T18:28:36.487319Z","caller":"traceutil/trace.go:171","msg":"trace[1562793776] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:685; }","duration":"2.373562581s","start":"2026-05-19T18:28:34.113741Z","end":"2026-05-19T18:28:36.487304Z","steps":["trace[1562793776] 'agreement among raft nodes before linearized reading' (duration: 2.373393747s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.487335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.177802ms","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-05-19T18:28:36.487354Z","caller":"traceutil/trace.go:171","msg":"trace[80448243] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:685; }","duration":"791.260214ms","start":"2026-05-19T18:28:35.696089Z","end":"2026-05-19T18:28:36.487349Z","steps":["trace[80448243] 'agreement among raft nodes before linearized reading' (duration: 791.210033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.487373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:35.696049Z","time spent":"791.319516ms","remote":"127.0.0.1:57096","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-05-19T18:28:36.487364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:34.113721Z","time spent":"2.373630522s","remote":"127.0.0.1:56858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-05-19T18:28:36.487375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.507403528s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:28:36.487443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.775541022s","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-05-19T18:28:36.487434Z","caller":"traceutil/trace.go:171","msg":"trace[2044460427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"1.507490061s","start":"2026-05-19T18:28:34.979928Z","end":"2026-05-19T18:28:36.487418Z","steps":["trace[2044460427] 'agreement among raft nodes before linearized reading' (duration: 1.507402818s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:36.487461Z","caller":"traceutil/trace.go:171","msg":"trace[546511327] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:685; }","duration":"1.775587643s","start":"2026-05-19T18:28:34.711868Z","end":"2026-05-19T18:28:36.487455Z","steps":["trace[546511327] 'agreement among raft nodes before linearized reading' (duration: 1.775541332s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.487479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:34.711847Z","time spent":"1.775628294s","remote":"127.0.0.1:57096","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-05-19T18:28:36.487477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:34.979906Z","time spent":"1.507560942s","remote":"127.0.0.1:56794","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-05-19T18:28:36.487284Z","caller":"traceutil/trace.go:171","msg":"trace[2107393449] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:685; }","duration":"1.789129557s","start":"2026-05-19T18:28:34.698147Z","end":"2026-05-19T18:28:36.487276Z","steps":["trace[2107393449] 'agreement among raft nodes before linearized reading' (duration: 1.789043345s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:36.48758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:34.69813Z","time spent":"1.789433035s","remote":"127.0.0.1:57096","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":"info","ts":"2026-05-19T18:28:36.663937Z","caller":"traceutil/trace.go:171","msg":"trace[870446610] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"170.540987ms","start":"2026-05-19T18:28:36.493382Z","end":"2026-05-19T18:28:36.663923Z","steps":["trace[870446610] 'process raft request' (duration: 170.187757ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:36.664367Z","caller":"traceutil/trace.go:171","msg":"trace[1741368391] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"170.520525ms","start":"2026-05-19T18:28:36.493836Z","end":"2026-05-19T18:28:36.664356Z","steps":["trace[1741368391] 'process raft request' (duration: 169.842557ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:36.664541Z","caller":"traceutil/trace.go:171","msg":"trace[1721710071] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"168.582956ms","start":"2026-05-19T18:28:36.495949Z","end":"2026-05-19T18:28:36.664532Z","steps":["trace[1721710071] 'process raft request' (duration: 167.763173ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:36.665262Z","caller":"traceutil/trace.go:171","msg":"trace[1847471515] linearizableReadLoop","detail":"{readStateIndex:711; appliedIndex:707; }","duration":"168.209155ms","start":"2026-05-19T18:28:36.497008Z","end":"2026-05-19T18:28:36.665217Z","steps":["trace[1847471515] 'read index received' (duration: 151.59415ms)","trace[1847471515] 'applied index is now lower than readState.Index' (duration: 16.612785ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:28:36.665352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.325239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:28:36.665446Z","caller":"traceutil/trace.go:171","msg":"trace[1092392324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:688; }","duration":"168.431332ms","start":"2026-05-19T18:28:36.497004Z","end":"2026-05-19T18:28:36.665435Z","steps":["trace[1092392324] 'agreement among raft nodes before linearized reading' (duration: 168.302349ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:42.149381Z","caller":"traceutil/trace.go:171","msg":"trace[1304112342] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"116.696826ms","start":"2026-05-19T18:28:42.032662Z","end":"2026-05-19T18:28:42.149359Z","steps":["trace[1304112342] 'process raft request' (duration: 112.802264ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:47.876239Z","caller":"traceutil/trace.go:171","msg":"trace[522953116] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"158.161142ms","start":"2026-05-19T18:28:47.71806Z","end":"2026-05-19T18:28:47.876221Z","steps":["trace[522953116] 'process raft request' (duration: 158.013528ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:28:50.967427Z","caller":"traceutil/trace.go:171","msg":"trace[1697209573] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"317.054392ms","start":"2026-05-19T18:28:50.650338Z","end":"2026-05-19T18:28:50.967392Z","steps":["trace[1697209573] 'process raft request' (duration: 316.790006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:50.967665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:50.650319Z","time spent":"317.218719ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:50.96819Z","caller":"traceutil/trace.go:171","msg":"trace[1257040475] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:810; }","duration":"234.663006ms","start":"2026-05-19T18:28:50.73347Z","end":"2026-05-19T18:28:50.968133Z","steps":["trace[1257040475] 'read index received' (duration: 233.562047ms)","trace[1257040475] 'applied index is now lower than readState.Index' (duration: 1.096558ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:50.968306Z","caller":"traceutil/trace.go:171","msg":"trace[82584427] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"317.445224ms","start":"2026-05-19T18:28:50.650846Z","end":"2026-05-19T18:28:50.968292Z","steps":["trace[82584427] 'process raft request' (duration: 316.649384ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:50.968503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.029225ms","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-05-19T18:28:50.969335Z","caller":"traceutil/trace.go:171","msg":"trace[997975073] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:786; }","duration":"235.897638ms","start":"2026-05-19T18:28:50.733409Z","end":"2026-05-19T18:28:50.969306Z","steps":["trace[997975073] 'agreement among raft nodes before linearized reading' (duration: 234.936933ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:50.968787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.382381ms","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-05-19T18:28:50.969531Z","caller":"traceutil/trace.go:171","msg":"trace[105649641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:786; }","duration":"229.142401ms","start":"2026-05-19T18:28:50.740372Z","end":"2026-05-19T18:28:50.969514Z","steps":["trace[105649641] 'agreement among raft nodes before linearized reading' (duration: 228.32572ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:50.968873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.007372ms","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-05-19T18:28:50.969742Z","caller":"traceutil/trace.go:171","msg":"trace[1088662061] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:786; }","duration":"228.890544ms","start":"2026-05-19T18:28:50.740842Z","end":"2026-05-19T18:28:50.969732Z","steps":["trace[1088662061] 'agreement among raft nodes before linearized reading' (duration: 227.98359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:50.969984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:50.650829Z","time spent":"318.134892ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:28:54.530173Z","caller":"traceutil/trace.go:171","msg":"trace[1716259107] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:830; }","duration":"412.958444ms","start":"2026-05-19T18:28:54.117191Z","end":"2026-05-19T18:28:54.53015Z","steps":["trace[1716259107] 'read index received' (duration: 412.704558ms)","trace[1716259107] 'applied index is now lower than readState.Index' (duration: 252.916µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:28:54.53026Z","caller":"traceutil/trace.go:171","msg":"trace[1541163567] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"454.967475ms","start":"2026-05-19T18:28:54.075235Z","end":"2026-05-19T18:28:54.530202Z","steps":["trace[1541163567] 'process raft request' (duration: 454.725499ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:54.531057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.826138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T18:28:54.531222Z","caller":"traceutil/trace.go:171","msg":"trace[1462029158] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:804; }","duration":"413.983083ms","start":"2026-05-19T18:28:54.117158Z","end":"2026-05-19T18:28:54.531141Z","steps":["trace[1462029158] 'agreement among raft nodes before linearized reading' (duration: 413.172332ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:54.531329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:54.117146Z","time spent":"414.134427ms","remote":"127.0.0.1:56858","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.204.45.72\" "} {"level":"warn","ts":"2026-05-19T18:28:54.531345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.136775ms","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-05-19T18:28:54.531529Z","caller":"traceutil/trace.go:171","msg":"trace[1144605770] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:804; }","duration":"333.265908ms","start":"2026-05-19T18:28:54.198168Z","end":"2026-05-19T18:28:54.531434Z","steps":["trace[1144605770] 'agreement among raft nodes before linearized reading' (duration: 332.352355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:54.531609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:54.198111Z","time spent":"333.470223ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":29,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:28:54.532067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:28:54.075216Z","time spent":"455.302924ms","remote":"127.0.0.1:57064","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:28:54.537213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.416953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:28:54.53727Z","caller":"traceutil/trace.go:171","msg":"trace[710546819] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:804; }","duration":"217.506916ms","start":"2026-05-19T18:28:54.31974Z","end":"2026-05-19T18:28:54.537247Z","steps":["trace[710546819] 'agreement among raft nodes before linearized reading' (duration: 212.506274ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:28:59.136443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.70429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-19T18:28:59.136512Z","caller":"traceutil/trace.go:171","msg":"trace[1419118917] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:852; }","duration":"115.822393ms","start":"2026-05-19T18:28:59.020671Z","end":"2026-05-19T18:28:59.136493Z","steps":["trace[1419118917] 'range keys from in-memory index tree' (duration: 115.594738ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:00.220763Z","caller":"traceutil/trace.go:171","msg":"trace[434569840] transaction","detail":"{read_only:false; response_revision:868; number_of_response:1; }","duration":"110.372991ms","start":"2026-05-19T18:29:00.11033Z","end":"2026-05-19T18:29:00.220703Z","steps":["trace[434569840] 'process raft request' (duration: 110.117183ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:11.341985Z","caller":"traceutil/trace.go:171","msg":"trace[1269276197] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:989; }","duration":"107.456504ms","start":"2026-05-19T18:29:11.234504Z","end":"2026-05-19T18:29:11.341961Z","steps":["trace[1269276197] 'read index received' (duration: 63.218555ms)","trace[1269276197] 'applied index is now lower than readState.Index' (duration: 44.237099ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:29:11.342068Z","caller":"traceutil/trace.go:171","msg":"trace[495181349] transaction","detail":"{read_only:false; response_revision:956; number_of_response:1; }","duration":"108.925573ms","start":"2026-05-19T18:29:11.233111Z","end":"2026-05-19T18:29:11.342036Z","steps":["trace[495181349] 'process raft request' (duration: 64.771536ms)","trace[495181349] 'compare' (duration: 43.965562ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:29:11.342403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.872655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-19T18:29:11.342468Z","caller":"traceutil/trace.go:171","msg":"trace[130405313] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:956; }","duration":"107.974269ms","start":"2026-05-19T18:29:11.234478Z","end":"2026-05-19T18:29:11.342452Z","steps":["trace[130405313] 'agreement among raft nodes before linearized reading' (duration: 107.615499ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:11.342692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.183534ms","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-05-19T18:29:11.342834Z","caller":"traceutil/trace.go:171","msg":"trace[1371267471] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:956; }","duration":"108.360488ms","start":"2026-05-19T18:29:11.234457Z","end":"2026-05-19T18:29:11.342818Z","steps":["trace[1371267471] 'agreement among raft nodes before linearized reading' (duration: 107.765642ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:18.100528Z","caller":"traceutil/trace.go:171","msg":"trace[1824279924] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"115.872035ms","start":"2026-05-19T18:29:17.98463Z","end":"2026-05-19T18:29:18.100502Z","steps":["trace[1824279924] 'read index received' (duration: 115.414923ms)","trace[1824279924] 'applied index is now lower than readState.Index' (duration: 455.782µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:29:18.100604Z","caller":"traceutil/trace.go:171","msg":"trace[714249539] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"135.127689ms","start":"2026-05-19T18:29:17.965446Z","end":"2026-05-19T18:29:18.100573Z","steps":["trace[714249539] 'process raft request' (duration: 134.686247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:18.100964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.310496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:29:18.101027Z","caller":"traceutil/trace.go:171","msg":"trace[510161484] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:979; }","duration":"116.433619ms","start":"2026-05-19T18:29:17.984581Z","end":"2026-05-19T18:29:18.101015Z","steps":["trace[510161484] 'agreement among raft nodes before linearized reading' (duration: 116.015188ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:30.53162Z","caller":"traceutil/trace.go:171","msg":"trace[102046892] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"397.438789ms","start":"2026-05-19T18:29:30.134156Z","end":"2026-05-19T18:29:30.531595Z","steps":["trace[102046892] 'process raft request' (duration: 397.297026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:30.53177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:30.134133Z","time spent":"397.562412ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:29:31.66419Z","caller":"traceutil/trace.go:171","msg":"trace[1259939149] linearizableReadLoop","detail":"{readStateIndex:1062; appliedIndex:1061; }","duration":"340.408345ms","start":"2026-05-19T18:29:31.323763Z","end":"2026-05-19T18:29:31.664171Z","steps":["trace[1259939149] 'read index received' (duration: 340.299193ms)","trace[1259939149] 'applied index is now lower than readState.Index' (duration: 108.212µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:29:31.664325Z","caller":"traceutil/trace.go:171","msg":"trace[1295336597] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"349.222386ms","start":"2026-05-19T18:29:31.315025Z","end":"2026-05-19T18:29:31.664247Z","steps":["trace[1295336597] 'process raft request' (duration: 349.009101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:31.664406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.04339ms","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-05-19T18:29:31.664433Z","caller":"traceutil/trace.go:171","msg":"trace[1206610366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1024; }","duration":"239.157204ms","start":"2026-05-19T18:29:31.425268Z","end":"2026-05-19T18:29:31.664425Z","steps":["trace[1206610366] 'agreement among raft nodes before linearized reading' (duration: 239.02276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:31.664446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.482517ms","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-05-19T18:29:31.664451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.675892ms","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-05-19T18:29:31.664488Z","caller":"traceutil/trace.go:171","msg":"trace[229795046] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1024; }","duration":"167.582129ms","start":"2026-05-19T18:29:31.496898Z","end":"2026-05-19T18:29:31.66448Z","steps":["trace[229795046] 'agreement among raft nodes before linearized reading' (duration: 167.463006ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:31.664515Z","caller":"traceutil/trace.go:171","msg":"trace[549534576] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1024; }","duration":"340.764924ms","start":"2026-05-19T18:29:31.323732Z","end":"2026-05-19T18:29:31.664497Z","steps":["trace[549534576] 'agreement among raft nodes before linearized reading' (duration: 340.555849ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:31.664511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:31.314998Z","time spent":"349.413161ms","remote":"127.0.0.1:57096","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-05-19T18:29:31.664559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:31.323719Z","time spent":"340.827936ms","remote":"127.0.0.1:57096","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-05-19T18:29:31.664629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.148358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T18:29:31.664659Z","caller":"traceutil/trace.go:171","msg":"trace[1227015684] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1024; }","duration":"164.771145ms","start":"2026-05-19T18:29:31.499877Z","end":"2026-05-19T18:29:31.664648Z","steps":["trace[1227015684] 'agreement among raft nodes before linearized reading' (duration: 164.430647ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:53.917225Z","caller":"traceutil/trace.go:171","msg":"trace[1238038541] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"151.776106ms","start":"2026-05-19T18:29:53.765427Z","end":"2026-05-19T18:29:53.917203Z","steps":["trace[1238038541] 'read index received' (duration: 151.554739ms)","trace[1238038541] 'applied index is now lower than readState.Index' (duration: 220.117µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:29:53.917335Z","caller":"traceutil/trace.go:171","msg":"trace[456521062] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"152.654809ms","start":"2026-05-19T18:29:53.764626Z","end":"2026-05-19T18:29:53.917281Z","steps":["trace[456521062] 'process raft request' (duration: 152.432262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:53.917623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.170935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T18:29:53.917669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.441636ms","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-05-19T18:29:53.917658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.986859ms","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-05-19T18:29:53.91773Z","caller":"traceutil/trace.go:171","msg":"trace[720945161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1096; }","duration":"138.525318ms","start":"2026-05-19T18:29:53.779182Z","end":"2026-05-19T18:29:53.917708Z","steps":["trace[720945161] 'agreement among raft nodes before linearized reading' (duration: 138.391085ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:53.917723Z","caller":"traceutil/trace.go:171","msg":"trace[796167945] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1096; }","duration":"152.274827ms","start":"2026-05-19T18:29:53.765399Z","end":"2026-05-19T18:29:53.917674Z","steps":["trace[796167945] 'agreement among raft nodes before linearized reading' (duration: 152.026561ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:53.917812Z","caller":"traceutil/trace.go:171","msg":"trace[525826013] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1096; }","duration":"147.155794ms","start":"2026-05-19T18:29:53.77062Z","end":"2026-05-19T18:29:53.917776Z","steps":["trace[525826013] 'agreement among raft nodes before linearized reading' (duration: 146.844976ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:53.91786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.744717ms","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-05-19T18:29:53.917951Z","caller":"traceutil/trace.go:171","msg":"trace[984748464] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1096; }","duration":"145.866171ms","start":"2026-05-19T18:29:53.772069Z","end":"2026-05-19T18:29:53.917935Z","steps":["trace[984748464] 'agreement among raft nodes before linearized reading' (duration: 145.573313ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:54.248985Z","caller":"traceutil/trace.go:171","msg":"trace[785994685] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"327.132618ms","start":"2026-05-19T18:29:53.9218Z","end":"2026-05-19T18:29:54.248932Z","steps":["trace[785994685] 'process raft request' (duration: 323.283417ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:54.249389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:53.921777Z","time spent":"327.502898ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:29:54.281892Z","caller":"traceutil/trace.go:171","msg":"trace[88266614] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"359.809124ms","start":"2026-05-19T18:29:53.922043Z","end":"2026-05-19T18:29:54.281852Z","steps":["trace[88266614] 'process raft request' (duration: 359.475536ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:54.281945Z","caller":"traceutil/trace.go:171","msg":"trace[1745182441] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"359.522875ms","start":"2026-05-19T18:29:53.922383Z","end":"2026-05-19T18:29:54.281905Z","steps":["trace[1745182441] 'process raft request' (duration: 359.344101ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:54.282534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:53.922014Z","time spent":"360.407379ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:29:54.282698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:53.922363Z","time spent":"360.213094ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:29:54.282157Z","caller":"traceutil/trace.go:171","msg":"trace[1389803183] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"359.425294ms","start":"2026-05-19T18:29:53.9227Z","end":"2026-05-19T18:29:54.282125Z","steps":["trace[1389803183] 'process raft request' (duration: 359.089024ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:54.283194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:53.922685Z","time spent":"360.327678ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:29:54.282345Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.795031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:29:54.283318Z","caller":"traceutil/trace.go:171","msg":"trace[564581053] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1100; }","duration":"300.878399ms","start":"2026-05-19T18:29:53.982409Z","end":"2026-05-19T18:29:54.283288Z","steps":["trace[564581053] 'agreement among raft nodes before linearized reading' (duration: 299.812562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:29:54.283394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:29:53.982378Z","time spent":"300.997454ms","remote":"127.0.0.1:56794","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-05-19T18:29:54.282159Z","caller":"traceutil/trace.go:171","msg":"trace[757493031] linearizableReadLoop","detail":"{readStateIndex:1142; appliedIndex:1138; }","duration":"299.622747ms","start":"2026-05-19T18:29:53.982482Z","end":"2026-05-19T18:29:54.282105Z","steps":["trace[757493031] 'read index received' (duration: 262.623478ms)","trace[757493031] 'applied index is now lower than readState.Index' (duration: 36.995969ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:29:54.283756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.907276ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.72\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-19T18:29:54.283827Z","caller":"traceutil/trace.go:171","msg":"trace[361910326] range","detail":"{range_begin:/registry/masterleases/199.204.45.72; range_end:; response_count:1; response_revision:1100; }","duration":"163.031199ms","start":"2026-05-19T18:29:54.120775Z","end":"2026-05-19T18:29:54.283806Z","steps":["trace[361910326] 'agreement among raft nodes before linearized reading' (duration: 162.827334ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:56.418523Z","caller":"traceutil/trace.go:171","msg":"trace[2056643971] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"126.591075ms","start":"2026-05-19T18:29:56.291909Z","end":"2026-05-19T18:29:56.4185Z","steps":["trace[2056643971] 'process raft request' (duration: 78.449985ms)","trace[2056643971] 'compare' (duration: 47.841773ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:29:56.418714Z","caller":"traceutil/trace.go:171","msg":"trace[604280360] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"126.382101ms","start":"2026-05-19T18:29:56.292315Z","end":"2026-05-19T18:29:56.418697Z","steps":["trace[604280360] 'process raft request' (duration: 126.150814ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:29:56.418875Z","caller":"traceutil/trace.go:171","msg":"trace[503327808] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"126.480553ms","start":"2026-05-19T18:29:56.292356Z","end":"2026-05-19T18:29:56.418837Z","steps":["trace[503327808] 'process raft request' (duration: 126.257768ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:07.74591Z","caller":"traceutil/trace.go:171","msg":"trace[579321079] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"122.216171ms","start":"2026-05-19T18:30:07.623658Z","end":"2026-05-19T18:30:07.745874Z","steps":["trace[579321079] 'process raft request' (duration: 121.919833ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:10.081971Z","caller":"traceutil/trace.go:171","msg":"trace[296008488] linearizableReadLoop","detail":"{readStateIndex:1247; appliedIndex:1246; }","duration":"368.017103ms","start":"2026-05-19T18:30:09.713917Z","end":"2026-05-19T18:30:10.081934Z","steps":["trace[296008488] 'read index received' (duration: 364.50885ms)","trace[296008488] 'applied index is now lower than readState.Index' (duration: 3.506753ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:10.082129Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.177027ms","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-05-19T18:30:10.082829Z","caller":"traceutil/trace.go:171","msg":"trace[1173448466] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1199; }","duration":"368.923226ms","start":"2026-05-19T18:30:09.713882Z","end":"2026-05-19T18:30:10.082805Z","steps":["trace[1173448466] 'agreement among raft nodes before linearized reading' (duration: 368.162106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:10.082897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:09.713858Z","time spent":"369.015118ms","remote":"127.0.0.1:58066","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-05-19T18:30:10.996707Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060196,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:11.497109Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060196,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:11.998137Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060196,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:12.49831Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060196,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:12.800834Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.305889098s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T18:30:12.801588Z","caller":"traceutil/trace.go:171","msg":"trace[210159849] transaction","detail":"{read_only:false; response_revision:1202; number_of_response:1; }","duration":"2.30671351s","start":"2026-05-19T18:30:10.494848Z","end":"2026-05-19T18:30:12.801562Z","steps":["trace[210159849] 'process raft request' (duration: 2.306319319s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.801755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:10.494816Z","time spent":"2.306847973s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:30:12.802831Z","caller":"traceutil/trace.go:171","msg":"trace[266469266] linearizableReadLoop","detail":"{readStateIndex:1253; appliedIndex:1249; }","duration":"2.306337609s","start":"2026-05-19T18:30:10.496467Z","end":"2026-05-19T18:30:12.802804Z","steps":["trace[266469266] 'read index received' (duration: 2.304676176s)","trace[266469266] 'applied index is now lower than readState.Index' (duration: 1.660403ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:12.80318Z","caller":"traceutil/trace.go:171","msg":"trace[1684946527] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"2.305839957s","start":"2026-05-19T18:30:10.497327Z","end":"2026-05-19T18:30:12.803167Z","steps":["trace[1684946527] 'process raft request' (duration: 2.305210511s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.80327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:10.497309Z","time spent":"2.305897598s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:30:12.803434Z","caller":"traceutil/trace.go:171","msg":"trace[1249115524] transaction","detail":"{read_only:false; response_revision:1204; number_of_response:1; }","duration":"2.167428667s","start":"2026-05-19T18:30:10.635995Z","end":"2026-05-19T18:30:12.803424Z","steps":["trace[1249115524] 'process raft request' (duration: 2.166666907s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.80349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:10.635976Z","time spent":"2.167488498s","remote":"127.0.0.1:57096","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-05-19T18:30:12.803591Z","caller":"traceutil/trace.go:171","msg":"trace[1903383757] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"2.114898687s","start":"2026-05-19T18:30:10.688683Z","end":"2026-05-19T18:30:12.803582Z","steps":["trace[1903383757] 'process raft request' (duration: 2.114079925s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.803635Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:10.688661Z","time spent":"2.114947447s","remote":"127.0.0.1:57096","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-05-19T18:30:12.803772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.307299025s","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-05-19T18:30:12.803797Z","caller":"traceutil/trace.go:171","msg":"trace[890123168] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1205; }","duration":"2.307334636s","start":"2026-05-19T18:30:10.496454Z","end":"2026-05-19T18:30:12.803789Z","steps":["trace[890123168] 'agreement among raft nodes before linearized reading' (duration: 2.307241384s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.803827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:10.496449Z","time spent":"2.307371938s","remote":"127.0.0.1:57096","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-05-19T18:30:12.803973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.829857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:12.804036Z","caller":"traceutil/trace.go:171","msg":"trace[110981770] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1205; }","duration":"823.930639ms","start":"2026-05-19T18:30:11.980089Z","end":"2026-05-19T18:30:12.80402Z","steps":["trace[110981770] 'agreement among raft nodes before linearized reading' (duration: 823.822146ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.804069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:11.980075Z","time spent":"823.985651ms","remote":"127.0.0.1:57836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:30:12.804312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.338849ms","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-05-19T18:30:12.804339Z","caller":"traceutil/trace.go:171","msg":"trace[1639103785] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1205; }","duration":"447.391022ms","start":"2026-05-19T18:30:12.35694Z","end":"2026-05-19T18:30:12.804331Z","steps":["trace[1639103785] 'agreement among raft nodes before linearized reading' (duration: 447.270888ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.804363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:12.356927Z","time spent":"447.429543ms","remote":"127.0.0.1:57096","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-05-19T18:30:12.804414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"823.407416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:12.804446Z","caller":"traceutil/trace.go:171","msg":"trace[417713691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1205; }","duration":"823.452287ms","start":"2026-05-19T18:30:11.980985Z","end":"2026-05-19T18:30:12.804437Z","steps":["trace[417713691] 'agreement among raft nodes before linearized reading' (duration: 823.403596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.804471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:11.980961Z","time spent":"823.504598ms","remote":"127.0.0.1:56794","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-05-19T18:30:12.804646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.489586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-19T18:30:12.804669Z","caller":"traceutil/trace.go:171","msg":"trace[1810072501] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1205; }","duration":"708.534077ms","start":"2026-05-19T18:30:12.096127Z","end":"2026-05-19T18:30:12.804661Z","steps":["trace[1810072501] 'agreement among raft nodes before linearized reading' (duration: 708.464385ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:12.80469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:12.096113Z","time spent":"708.572518ms","remote":"127.0.0.1:57096","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":"info","ts":"2026-05-19T18:30:14.361162Z","caller":"traceutil/trace.go:171","msg":"trace[1599172255] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"203.992324ms","start":"2026-05-19T18:30:14.157136Z","end":"2026-05-19T18:30:14.361129Z","steps":["trace[1599172255] 'process raft request' (duration: 108.17656ms)","trace[1599172255] 'compare' (duration: 95.465575ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:25.083628Z","caller":"traceutil/trace.go:171","msg":"trace[839884982] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"156.272952ms","start":"2026-05-19T18:30:24.927313Z","end":"2026-05-19T18:30:25.083586Z","steps":["trace[839884982] 'read index received' (duration: 156.093058ms)","trace[839884982] 'applied index is now lower than readState.Index' (duration: 178.934µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:25.083984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.646772ms","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-05-19T18:30:25.084017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.868227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:25.084033Z","caller":"traceutil/trace.go:171","msg":"trace[1927196098] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"175.670106ms","start":"2026-05-19T18:30:24.908333Z","end":"2026-05-19T18:30:25.084003Z","steps":["trace[1927196098] 'process raft request' (duration: 175.09642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:25.08406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.829682ms","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-05-19T18:30:25.0841Z","caller":"traceutil/trace.go:171","msg":"trace[1945048676] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1243; }","duration":"104.005791ms","start":"2026-05-19T18:30:24.980077Z","end":"2026-05-19T18:30:25.084083Z","steps":["trace[1945048676] 'agreement among raft nodes before linearized reading' (duration: 103.856996ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:25.08413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.525547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-19T18:30:25.084154Z","caller":"traceutil/trace.go:171","msg":"trace[1007574408] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1243; }","duration":"140.585657ms","start":"2026-05-19T18:30:24.943563Z","end":"2026-05-19T18:30:25.084149Z","steps":["trace[1007574408] 'agreement among raft nodes before linearized reading' (duration: 140.527006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:25.084229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.704621ms","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-05-19T18:30:25.08405Z","caller":"traceutil/trace.go:171","msg":"trace[2115294618] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1243; }","duration":"156.749956ms","start":"2026-05-19T18:30:24.927285Z","end":"2026-05-19T18:30:25.084035Z","steps":["trace[2115294618] 'agreement among raft nodes before linearized reading' (duration: 156.543209ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:25.084303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.484888ms","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-05-19T18:30:25.084304Z","caller":"traceutil/trace.go:171","msg":"trace[609835902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1243; }","duration":"140.797113ms","start":"2026-05-19T18:30:24.943493Z","end":"2026-05-19T18:30:25.08429Z","steps":["trace[609835902] 'agreement among raft nodes before linearized reading' (duration: 140.655449ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:25.084124Z","caller":"traceutil/trace.go:171","msg":"trace[247507908] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1243; }","duration":"141.932843ms","start":"2026-05-19T18:30:24.942176Z","end":"2026-05-19T18:30:25.084109Z","steps":["trace[247507908] 'agreement among raft nodes before linearized reading' (duration: 141.746338ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:25.084321Z","caller":"traceutil/trace.go:171","msg":"trace[345465363] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1243; }","duration":"139.52299ms","start":"2026-05-19T18:30:24.944792Z","end":"2026-05-19T18:30:25.084315Z","steps":["trace[345465363] 'agreement among raft nodes before linearized reading' (duration: 139.455878ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:28.121139Z","caller":"traceutil/trace.go:171","msg":"trace[646699937] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1313; }","duration":"138.581375ms","start":"2026-05-19T18:30:27.982539Z","end":"2026-05-19T18:30:28.12112Z","steps":["trace[646699937] 'read index received' (duration: 138.487232ms)","trace[646699937] 'applied index is now lower than readState.Index' (duration: 93.532µs)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:28.121254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.695867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:28.121281Z","caller":"traceutil/trace.go:171","msg":"trace[66958527] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1263; }","duration":"138.769269ms","start":"2026-05-19T18:30:27.982503Z","end":"2026-05-19T18:30:28.121272Z","steps":["trace[66958527] 'agreement among raft nodes before linearized reading' (duration: 138.688517ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:28.121253Z","caller":"traceutil/trace.go:171","msg":"trace[273769361] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"156.398476ms","start":"2026-05-19T18:30:27.964786Z","end":"2026-05-19T18:30:28.121184Z","steps":["trace[273769361] 'process raft request' (duration: 156.228882ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:29.310942Z","caller":"traceutil/trace.go:171","msg":"trace[731778424] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"222.406002ms","start":"2026-05-19T18:30:29.08851Z","end":"2026-05-19T18:30:29.310916Z","steps":["trace[731778424] 'process raft request' (duration: 123.108336ms)","trace[731778424] 'compare' (duration: 99.123501ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:29.311099Z","caller":"traceutil/trace.go:171","msg":"trace[870862734] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1316; }","duration":"198.858139ms","start":"2026-05-19T18:30:29.112226Z","end":"2026-05-19T18:30:29.311084Z","steps":["trace[870862734] 'read index received' (duration: 99.536393ms)","trace[870862734] 'applied index is now lower than readState.Index' (duration: 99.320666ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:29.311307Z","caller":"traceutil/trace.go:171","msg":"trace[741685396] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"217.736348ms","start":"2026-05-19T18:30:29.093559Z","end":"2026-05-19T18:30:29.311295Z","steps":["trace[741685396] 'process raft request' (duration: 217.427809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:29.311569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.301631ms","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-05-19T18:30:29.311608Z","caller":"traceutil/trace.go:171","msg":"trace[221616123] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1267; }","duration":"199.379453ms","start":"2026-05-19T18:30:29.112219Z","end":"2026-05-19T18:30:29.311598Z","steps":["trace[221616123] 'agreement among raft nodes before linearized reading' (duration: 199.221829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:29.311827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.280779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-19T18:30:29.31191Z","caller":"traceutil/trace.go:171","msg":"trace[584332783] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1267; }","duration":"199.400623ms","start":"2026-05-19T18:30:29.112495Z","end":"2026-05-19T18:30:29.311896Z","steps":["trace[584332783] 'agreement among raft nodes before linearized reading' (duration: 199.247778ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:29.31209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.846399ms","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-05-19T18:30:29.312148Z","caller":"traceutil/trace.go:171","msg":"trace[787536620] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1267; }","duration":"198.92379ms","start":"2026-05-19T18:30:29.113213Z","end":"2026-05-19T18:30:29.312137Z","steps":["trace[787536620] 'agreement among raft nodes before linearized reading' (duration: 198.789387ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:29.312201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.187707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-19T18:30:29.312264Z","caller":"traceutil/trace.go:171","msg":"trace[1200879394] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1267; }","duration":"199.26916ms","start":"2026-05-19T18:30:29.112983Z","end":"2026-05-19T18:30:29.312252Z","steps":["trace[1200879394] 'agreement among raft nodes before linearized reading' (duration: 199.088685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:29.312463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.693221ms","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-05-19T18:30:29.312513Z","caller":"traceutil/trace.go:171","msg":"trace[578601316] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1267; }","duration":"199.768532ms","start":"2026-05-19T18:30:29.112734Z","end":"2026-05-19T18:30:29.312503Z","steps":["trace[578601316] 'agreement among raft nodes before linearized reading' (duration: 199.647749ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:30.902355Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060359,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:31.357107Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.318023425s","expected-duration":"1s"} {"level":"info","ts":"2026-05-19T18:30:31.357756Z","caller":"traceutil/trace.go:171","msg":"trace[1731906351] linearizableReadLoop","detail":"{readStateIndex:1328; appliedIndex:1327; }","duration":"955.984151ms","start":"2026-05-19T18:30:30.401737Z","end":"2026-05-19T18:30:31.357721Z","steps":["trace[1731906351] 'read index received' (duration: 955.59206ms)","trace[1731906351] 'applied index is now lower than readState.Index' (duration: 390.311µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:31.357985Z","caller":"traceutil/trace.go:171","msg":"trace[1494788722] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"1.318922858s","start":"2026-05-19T18:30:30.039022Z","end":"2026-05-19T18:30:31.357945Z","steps":["trace[1494788722] 'process raft request' (duration: 1.318364533s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.358233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:30.039002Z","time spent":"1.319053861s","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5456,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:30:31.358257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.489134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-dj55v\" ","response":"range_response_count:1 size:11057"} {"level":"info","ts":"2026-05-19T18:30:31.358445Z","caller":"traceutil/trace.go:171","msg":"trace[1692682842] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-dj55v; range_end:; response_count:1; response_revision:1276; }","duration":"956.71302ms","start":"2026-05-19T18:30:30.401709Z","end":"2026-05-19T18:30:31.358422Z","steps":["trace[1692682842] 'agreement among raft nodes before linearized reading' (duration: 956.300529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.358502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:30.401695Z","time spent":"956.793592ms","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11079,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-dj55v\" "} {"level":"info","ts":"2026-05-19T18:30:31.69536Z","caller":"traceutil/trace.go:171","msg":"trace[528417229] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1276; }","duration":"659.712166ms","start":"2026-05-19T18:30:31.035625Z","end":"2026-05-19T18:30:31.695337Z","steps":["trace[528417229] 'process raft request' (duration: 643.243661ms)","trace[528417229] 'compare' (duration: 16.208568ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:31.695469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.035604Z","time spent":"659.808297ms","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30,"response count":0,"response size":5503,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:30:31.695642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.832512ms","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-05-19T18:30:31.695703Z","caller":"traceutil/trace.go:171","msg":"trace[444802762] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1277; }","duration":"360.941405ms","start":"2026-05-19T18:30:31.334748Z","end":"2026-05-19T18:30:31.695689Z","steps":["trace[444802762] 'agreement among raft nodes before linearized reading' (duration: 360.74949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.695739Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.334721Z","time spent":"361.009567ms","remote":"127.0.0.1:57096","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":"warn","ts":"2026-05-19T18:30:31.695888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.79539ms","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-05-19T18:30:31.695921Z","caller":"traceutil/trace.go:171","msg":"trace[345694830] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1277; }","duration":"647.863293ms","start":"2026-05-19T18:30:31.048048Z","end":"2026-05-19T18:30:31.695911Z","steps":["trace[345694830] 'agreement among raft nodes before linearized reading' (duration: 647.814072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.695944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.048018Z","time spent":"647.920365ms","remote":"127.0.0.1:57038","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:30:31.695944Z","caller":"traceutil/trace.go:171","msg":"trace[20045939] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"377.110562ms","start":"2026-05-19T18:30:31.318825Z","end":"2026-05-19T18:30:31.695935Z","steps":["trace[20045939] 'process raft request' (duration: 376.514857ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.695986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.318799Z","time spent":"377.161434ms","remote":"127.0.0.1:57096","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-05-19T18:30:31.695969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.942452ms","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-05-19T18:30:31.696038Z","caller":"traceutil/trace.go:171","msg":"trace[1557469816] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1277; }","duration":"362.067105ms","start":"2026-05-19T18:30:31.333958Z","end":"2026-05-19T18:30:31.696025Z","steps":["trace[1557469816] 'agreement among raft nodes before linearized reading' (duration: 361.837149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.69609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.333943Z","time spent":"362.140586ms","remote":"127.0.0.1:57096","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-05-19T18:30:31.696099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.302968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-19T18:30:31.695507Z","caller":"traceutil/trace.go:171","msg":"trace[235611278] linearizableReadLoop","detail":"{readStateIndex:1330; appliedIndex:1328; }","duration":"337.585247ms","start":"2026-05-19T18:30:31.357892Z","end":"2026-05-19T18:30:31.695478Z","steps":["trace[235611278] 'read index received' (duration: 320.959497ms)","trace[235611278] 'applied index is now lower than readState.Index' (duration: 16.62448ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:31.696117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.712369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:31.696144Z","caller":"traceutil/trace.go:171","msg":"trace[143358145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1277; }","duration":"717.763581ms","start":"2026-05-19T18:30:30.978375Z","end":"2026-05-19T18:30:31.696139Z","steps":["trace[143358145] 'agreement among raft nodes before linearized reading' (duration: 717.72619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.696161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:30.978361Z","time spent":"717.797041ms","remote":"127.0.0.1:56794","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-05-19T18:30:31.696162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.271034ms","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-05-19T18:30:31.696178Z","caller":"traceutil/trace.go:171","msg":"trace[2130570265] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1277; }","duration":"361.309054ms","start":"2026-05-19T18:30:31.334865Z","end":"2026-05-19T18:30:31.696174Z","steps":["trace[2130570265] 'agreement among raft nodes before linearized reading' (duration: 361.265653ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.696196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.334854Z","time spent":"361.336435ms","remote":"127.0.0.1:57096","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-05-19T18:30:31.696119Z","caller":"traceutil/trace.go:171","msg":"trace[1697339130] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1277; }","duration":"360.341599ms","start":"2026-05-19T18:30:31.335771Z","end":"2026-05-19T18:30:31.696113Z","steps":["trace[1697339130] 'agreement among raft nodes before linearized reading' (duration: 360.285208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.69625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.335755Z","time spent":"360.489793ms","remote":"127.0.0.1:57096","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-05-19T18:30:31.696251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.177633552s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T18:30:31.696249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.702742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-05-19T18:30:31.696302Z","caller":"traceutil/trace.go:171","msg":"trace[1578264496] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1277; }","duration":"1.177721604s","start":"2026-05-19T18:30:30.518564Z","end":"2026-05-19T18:30:31.696285Z","steps":["trace[1578264496] 'agreement among raft nodes before linearized reading' (duration: 1.177618342s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:31.696314Z","caller":"traceutil/trace.go:171","msg":"trace[733358360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1277; }","duration":"362.849696ms","start":"2026-05-19T18:30:31.333446Z","end":"2026-05-19T18:30:31.696296Z","steps":["trace[733358360] 'agreement among raft nodes before linearized reading' (duration: 362.595789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.696355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.333414Z","time spent":"362.929707ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T18:30:31.696354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:30.518545Z","time spent":"1.177794076s","remote":"127.0.0.1:57214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":29,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:30:31.696908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"411.630695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:31.696962Z","caller":"traceutil/trace.go:171","msg":"trace[823750462] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1277; }","duration":"411.754119ms","start":"2026-05-19T18:30:31.285193Z","end":"2026-05-19T18:30:31.696947Z","steps":["trace[823750462] 'agreement among raft nodes before linearized reading' (duration: 411.581925ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:31.697012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.285139Z","time spent":"411.860341ms","remote":"127.0.0.1:57900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-05-19T18:30:32.081611Z","caller":"traceutil/trace.go:171","msg":"trace[353608874] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"385.441283ms","start":"2026-05-19T18:30:31.696139Z","end":"2026-05-19T18:30:32.08158Z","steps":["trace[353608874] 'read index received' (duration: 332.940154ms)","trace[353608874] 'applied index is now lower than readState.Index' (duration: 52.499959ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:32.08168Z","caller":"traceutil/trace.go:171","msg":"trace[1670936066] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"709.746179ms","start":"2026-05-19T18:30:31.371903Z","end":"2026-05-19T18:30:32.081649Z","steps":["trace[1670936066] 'process raft request' (duration: 656.942652ms)","trace[1670936066] 'compare' (duration: 52.526519ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:32.082141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.371885Z","time spent":"710.18695ms","remote":"127.0.0.1:57008","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11371,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:30:32.08186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"718.955062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-19T18:30:32.08224Z","caller":"traceutil/trace.go:171","msg":"trace[195294733] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:1278; }","duration":"719.416845ms","start":"2026-05-19T18:30:31.362804Z","end":"2026-05-19T18:30:32.082221Z","steps":["trace[195294733] 'agreement among raft nodes before linearized reading' (duration: 718.932922ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:32.082331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.362787Z","time spent":"719.487567ms","remote":"127.0.0.1:57214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":686,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-05-19T18:30:32.134104Z","caller":"traceutil/trace.go:171","msg":"trace[1166786105] transaction","detail":"{read_only:false; response_revision:1284; number_of_response:1; }","duration":"431.767608ms","start":"2026-05-19T18:30:31.702307Z","end":"2026-05-19T18:30:32.134075Z","steps":["trace[1166786105] 'process raft request' (duration: 431.725717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:32.134261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.7023Z","time spent":"431.886351ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:30:32.134789Z","caller":"traceutil/trace.go:171","msg":"trace[308248949] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"435.201909ms","start":"2026-05-19T18:30:31.699569Z","end":"2026-05-19T18:30:32.134771Z","steps":["trace[308248949] 'process raft request' (duration: 434.232463ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:32.134877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.699557Z","time spent":"435.278201ms","remote":"127.0.0.1:57004","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5639,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:30:32.135311Z","caller":"traceutil/trace.go:171","msg":"trace[105157245] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"433.292718ms","start":"2026-05-19T18:30:31.702003Z","end":"2026-05-19T18:30:32.135295Z","steps":["trace[105157245] 'process raft request' (duration: 432.003744ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:32.13537Z","caller":"traceutil/trace.go:171","msg":"trace[1190325344] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"433.499864ms","start":"2026-05-19T18:30:31.701856Z","end":"2026-05-19T18:30:32.135356Z","steps":["trace[1190325344] 'process raft request' (duration: 432.087177ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:32.135378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.702Z","time spent":"433.34621ms","remote":"127.0.0.1:57096","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-05-19T18:30:32.135434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.701831Z","time spent":"433.574276ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T18:30:32.135432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.51725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:32.135512Z","caller":"traceutil/trace.go:171","msg":"trace[1847000071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1284; }","duration":"437.633383ms","start":"2026-05-19T18:30:31.697868Z","end":"2026-05-19T18:30:32.135501Z","steps":["trace[1847000071] 'agreement among raft nodes before linearized reading' (duration: 437.484449ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:32.135498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.992693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T18:30:32.135567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.697852Z","time spent":"437.689915ms","remote":"127.0.0.1:56808","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-05-19T18:30:32.135561Z","caller":"traceutil/trace.go:171","msg":"trace[731134454] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:1284; }","duration":"244.097836ms","start":"2026-05-19T18:30:31.891446Z","end":"2026-05-19T18:30:32.135544Z","steps":["trace[731134454] 'agreement among raft nodes before linearized reading' (duration: 243.970763ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:32.135199Z","caller":"traceutil/trace.go:171","msg":"trace[955907363] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"435.444955ms","start":"2026-05-19T18:30:31.699743Z","end":"2026-05-19T18:30:32.135187Z","steps":["trace[955907363] 'process raft request' (duration: 434.161211ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:32.135297Z","caller":"traceutil/trace.go:171","msg":"trace[1032944452] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"433.309889ms","start":"2026-05-19T18:30:31.70196Z","end":"2026-05-19T18:30:32.13527Z","steps":["trace[1032944452] 'process raft request' (duration: 432.012605ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:32.135771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.699735Z","time spent":"435.909727ms","remote":"127.0.0.1:57096","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-05-19T18:30:32.136159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:31.701956Z","time spent":"434.132151ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:30:32.752134Z","caller":"traceutil/trace.go:171","msg":"trace[257571541] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"328.565659ms","start":"2026-05-19T18:30:32.423545Z","end":"2026-05-19T18:30:32.752111Z","steps":["trace[257571541] 'process raft request' (duration: 328.424184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:32.752237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:32.423519Z","time spent":"328.670872ms","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:30:32.752238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.641741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:32.752123Z","caller":"traceutil/trace.go:171","msg":"trace[1216918553] linearizableReadLoop","detail":"{readStateIndex:1343; appliedIndex:1342; }","duration":"235.522078ms","start":"2026-05-19T18:30:32.516579Z","end":"2026-05-19T18:30:32.752101Z","steps":["trace[1216918553] 'read index received' (duration: 235.356294ms)","trace[1216918553] 'applied index is now lower than readState.Index' (duration: 164.904µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:32.752283Z","caller":"traceutil/trace.go:171","msg":"trace[1733223752] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1290; }","duration":"235.728514ms","start":"2026-05-19T18:30:32.516543Z","end":"2026-05-19T18:30:32.752272Z","steps":["trace[1733223752] 'agreement among raft nodes before linearized reading' (duration: 235.628951ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:33.481609Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060382,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:33.786088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.470507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:30:33.786379Z","caller":"traceutil/trace.go:171","msg":"trace[2087603517] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1343; }","duration":"805.521752ms","start":"2026-05-19T18:30:32.980824Z","end":"2026-05-19T18:30:33.786346Z","steps":["trace[2087603517] 'read index received' (duration: 586.736945ms)","trace[2087603517] 'applied index is now lower than readState.Index' (duration: 218.783567ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:33.786483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"805.652306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:33.786532Z","caller":"traceutil/trace.go:171","msg":"trace[1536935339] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1292; }","duration":"805.741998ms","start":"2026-05-19T18:30:32.980776Z","end":"2026-05-19T18:30:33.786518Z","steps":["trace[1536935339] 'agreement among raft nodes before linearized reading' (duration: 805.661176ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:33.786584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:32.980756Z","time spent":"805.815429ms","remote":"127.0.0.1:56808","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-05-19T18:30:33.786581Z","caller":"traceutil/trace.go:171","msg":"trace[254994594] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"1.029036322s","start":"2026-05-19T18:30:32.757503Z","end":"2026-05-19T18:30:33.786539Z","steps":["trace[254994594] 'process raft request' (duration: 810.044591ms)","trace[254994594] 'compare' (duration: 218.066537ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:33.786764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:32.757488Z","time spent":"1.029178076s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:30:33.786856Z","caller":"traceutil/trace.go:171","msg":"trace[665525901] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"702.403655ms","start":"2026-05-19T18:30:33.084433Z","end":"2026-05-19T18:30:33.786837Z","steps":["trace[665525901] 'process raft request' (duration: 701.757939ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:33.787389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:33.084406Z","time spent":"702.922318ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:30:33.839055Z","caller":"traceutil/trace.go:171","msg":"trace[1248610168] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"237.326546ms","start":"2026-05-19T18:30:33.601688Z","end":"2026-05-19T18:30:33.839014Z","steps":["trace[1248610168] 'process raft request' (duration: 237.193253ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:34.065406Z","caller":"traceutil/trace.go:171","msg":"trace[13631341] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1346; }","duration":"271.950642ms","start":"2026-05-19T18:30:33.793425Z","end":"2026-05-19T18:30:34.065376Z","steps":["trace[13631341] 'read index received' (duration: 45.601746ms)","trace[13631341] 'applied index is now lower than readState.Index' (duration: 226.347726ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:34.065659Z","caller":"traceutil/trace.go:171","msg":"trace[147916701] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"272.574718ms","start":"2026-05-19T18:30:33.793034Z","end":"2026-05-19T18:30:34.065609Z","steps":["trace[147916701] 'process raft request' (duration: 272.28439ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:34.065869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.411934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-05-19T18:30:34.065924Z","caller":"traceutil/trace.go:171","msg":"trace[1790227196] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1295; }","duration":"272.525457ms","start":"2026-05-19T18:30:33.793384Z","end":"2026-05-19T18:30:34.06591Z","steps":["trace[1790227196] 'agreement among raft nodes before linearized reading' (duration: 272.318352ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:34.066026Z","caller":"traceutil/trace.go:171","msg":"trace[437918968] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"363.744429ms","start":"2026-05-19T18:30:33.702272Z","end":"2026-05-19T18:30:34.066017Z","steps":["trace[437918968] 'process raft request' (duration: 362.840685ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:34.066173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:33.702219Z","time spent":"363.871271ms","remote":"127.0.0.1:57096","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-05-19T18:30:34.079117Z","caller":"traceutil/trace.go:171","msg":"trace[337853280] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"235.55854ms","start":"2026-05-19T18:30:33.843525Z","end":"2026-05-19T18:30:34.079084Z","steps":["trace[337853280] 'process raft request' (duration: 235.411546ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:40.808843Z","caller":"traceutil/trace.go:171","msg":"trace[184613300] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"126.581008ms","start":"2026-05-19T18:30:40.68223Z","end":"2026-05-19T18:30:40.808811Z","steps":["trace[184613300] 'process raft request' (duration: 53.404392ms)","trace[184613300] 'compare' (duration: 73.022641ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:40.817551Z","caller":"traceutil/trace.go:171","msg":"trace[597000777] transaction","detail":"{read_only:false; response_revision:1336; number_of_response:1; }","duration":"112.411893ms","start":"2026-05-19T18:30:40.705117Z","end":"2026-05-19T18:30:40.817529Z","steps":["trace[597000777] 'process raft request' (duration: 112.28014ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:41.084457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.895771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:41.084609Z","caller":"traceutil/trace.go:171","msg":"trace[114474962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1337; }","duration":"103.382574ms","start":"2026-05-19T18:30:40.981148Z","end":"2026-05-19T18:30:41.08453Z","steps":["trace[114474962] 'range keys from in-memory index tree' (duration: 102.816509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:42.397337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.96528ms","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-05-19T18:30:42.397472Z","caller":"traceutil/trace.go:171","msg":"trace[594798726] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1339; }","duration":"174.139605ms","start":"2026-05-19T18:30:42.223312Z","end":"2026-05-19T18:30:42.397451Z","steps":["trace[594798726] 'range keys from in-memory index tree' (duration: 173.94078ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:44.288553Z","caller":"traceutil/trace.go:171","msg":"trace[847767903] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"162.074186ms","start":"2026-05-19T18:30:44.12646Z","end":"2026-05-19T18:30:44.288534Z","steps":["trace[847767903] 'process raft request' (duration: 161.967393ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:44.64432Z","caller":"traceutil/trace.go:171","msg":"trace[981648102] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"128.16746ms","start":"2026-05-19T18:30:44.516126Z","end":"2026-05-19T18:30:44.644294Z","steps":["trace[981648102] 'process raft request' (duration: 52.516979ms)","trace[981648102] 'compare' (duration: 75.555158ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:44.709421Z","caller":"traceutil/trace.go:171","msg":"trace[1653749623] transaction","detail":"{read_only:false; response_revision:1351; number_of_response:1; }","duration":"192.965244ms","start":"2026-05-19T18:30:44.516438Z","end":"2026-05-19T18:30:44.709403Z","steps":["trace[1653749623] 'process raft request' (duration: 192.81906ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:44.709712Z","caller":"traceutil/trace.go:171","msg":"trace[349578500] transaction","detail":"{read_only:false; response_revision:1352; number_of_response:1; }","duration":"191.719849ms","start":"2026-05-19T18:30:44.517985Z","end":"2026-05-19T18:30:44.709705Z","steps":["trace[349578500] 'process raft request' (duration: 191.394111ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:44.710207Z","caller":"traceutil/trace.go:171","msg":"trace[857150696] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"191.965106ms","start":"2026-05-19T18:30:44.518216Z","end":"2026-05-19T18:30:44.710181Z","steps":["trace[857150696] 'process raft request' (duration: 191.851903ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:45.39747Z","caller":"traceutil/trace.go:171","msg":"trace[1703926527] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"130.421319ms","start":"2026-05-19T18:30:45.267024Z","end":"2026-05-19T18:30:45.397446Z","steps":["trace[1703926527] 'process raft request' (duration: 130.311906ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:46.243628Z","caller":"traceutil/trace.go:171","msg":"trace[393915575] linearizableReadLoop","detail":"{readStateIndex:1412; appliedIndex:1411; }","duration":"430.69226ms","start":"2026-05-19T18:30:45.812876Z","end":"2026-05-19T18:30:46.243568Z","steps":["trace[393915575] 'read index received' (duration: 430.603377ms)","trace[393915575] 'applied index is now lower than readState.Index' (duration: 85.282µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:46.243719Z","caller":"traceutil/trace.go:171","msg":"trace[141845030] transaction","detail":"{read_only:false; response_revision:1356; number_of_response:1; }","duration":"459.865661ms","start":"2026-05-19T18:30:45.783809Z","end":"2026-05-19T18:30:46.243675Z","steps":["trace[141845030] 'process raft request' (duration: 459.583793ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:46.244292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:45.783792Z","time spent":"460.433946ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:30:46.244014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"431.116531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-05-19T18:30:46.244619Z","caller":"traceutil/trace.go:171","msg":"trace[394295616] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1356; }","duration":"431.756788ms","start":"2026-05-19T18:30:45.812842Z","end":"2026-05-19T18:30:46.244599Z","steps":["trace[394295616] 'agreement among raft nodes before linearized reading' (duration: 430.939237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:46.244703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:45.812832Z","time spent":"431.85297ms","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":557,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-19T18:30:46.744567Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060524,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:47.397657Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.450029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:30:47.397856Z","caller":"traceutil/trace.go:171","msg":"trace[101085121] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"1.30007708s","start":"2026-05-19T18:30:46.09773Z","end":"2026-05-19T18:30:47.397807Z","steps":["trace[101085121] 'process raft request' (duration: 955.345414ms)","trace[101085121] 'compare' (duration: 343.441452ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:47.397945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.097706Z","time spent":"1.300184242s","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":782,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T18:30:47.406265Z","caller":"traceutil/trace.go:171","msg":"trace[1183346770] transaction","detail":"{read_only:false; response_revision:1358; number_of_response:1; }","duration":"1.157392177s","start":"2026-05-19T18:30:46.248859Z","end":"2026-05-19T18:30:47.406252Z","steps":["trace[1183346770] 'process raft request' (duration: 1.157258713s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:47.406355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.24883Z","time spent":"1.157485769s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T18:30:47.406335Z","caller":"traceutil/trace.go:171","msg":"trace[980287557] transaction","detail":"{read_only:false; response_revision:1359; number_of_response:1; }","duration":"1.151571653s","start":"2026-05-19T18:30:46.254743Z","end":"2026-05-19T18:30:47.406315Z","steps":["trace[980287557] 'process raft request' (duration: 1.15145821s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:47.406456Z","caller":"traceutil/trace.go:171","msg":"trace[2008997686] linearizableReadLoop","detail":"{readStateIndex:1416; appliedIndex:1412; }","duration":"1.162327307s","start":"2026-05-19T18:30:46.244116Z","end":"2026-05-19T18:30:47.406444Z","steps":["trace[2008997686] 'read index received' (duration: 809.047935ms)","trace[2008997686] 'applied index is now lower than readState.Index' (duration: 353.278042ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:47.406493Z","caller":"traceutil/trace.go:171","msg":"trace[1875570208] transaction","detail":"{read_only:false; response_revision:1360; number_of_response:1; }","duration":"1.110742002s","start":"2026-05-19T18:30:46.295743Z","end":"2026-05-19T18:30:47.406485Z","steps":["trace[1875570208] 'process raft request' (duration: 1.110484436s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:47.406532Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.295717Z","time spent":"1.110794835s","remote":"127.0.0.1:57096","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-05-19T18:30:47.406535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.425523408s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:47.40656Z","caller":"traceutil/trace.go:171","msg":"trace[574510236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1360; }","duration":"1.42559222s","start":"2026-05-19T18:30:45.98096Z","end":"2026-05-19T18:30:47.406552Z","steps":["trace[574510236] 'agreement among raft nodes before linearized reading' (duration: 1.425533009s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:47.406579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:45.98094Z","time spent":"1.425633661s","remote":"127.0.0.1:56794","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-05-19T18:30:47.406659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.320142901s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:47.406764Z","caller":"traceutil/trace.go:171","msg":"trace[174115943] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1360; }","duration":"1.320340346s","start":"2026-05-19T18:30:46.086401Z","end":"2026-05-19T18:30:47.406741Z","steps":["trace[174115943] 'agreement among raft nodes before linearized reading' (duration: 1.32010221s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:47.406812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.086369Z","time spent":"1.320430728s","remote":"127.0.0.1:58014","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:30:47.406848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.254725Z","time spent":"1.151673425s","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":911,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:30:47.906977Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060529,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:48.407492Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14680219939500060529,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T18:30:48.593147Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.18704599s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-19T18:30:48.733818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.239168ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T18:30:48.733962Z","caller":"traceutil/trace.go:171","msg":"trace[423170084] linearizableReadLoop","detail":"{readStateIndex:1417; appliedIndex:1416; }","duration":"1.327449105s","start":"2026-05-19T18:30:47.406474Z","end":"2026-05-19T18:30:48.733923Z","steps":["trace[423170084] 'read index received' (duration: 1.186844106s)","trace[423170084] 'applied index is now lower than readState.Index' (duration: 140.602919ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:48.734071Z","caller":"traceutil/trace.go:171","msg":"trace[927845727] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"1.331943673s","start":"2026-05-19T18:30:47.402114Z","end":"2026-05-19T18:30:48.734058Z","steps":["trace[927845727] 'process raft request' (duration: 1.191311944s)","trace[927845727] 'compare' (duration: 140.055174ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:30:48.734153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:47.402093Z","time spent":"1.332022375s","remote":"127.0.0.1:56920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":861,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T18:30:48.734511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326529949s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:48.734558Z","caller":"traceutil/trace.go:171","msg":"trace[977893003] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1361; }","duration":"1.326677803s","start":"2026-05-19T18:30:47.407867Z","end":"2026-05-19T18:30:48.734545Z","steps":["trace[977893003] 'agreement among raft nodes before linearized reading' (duration: 1.326603542s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.73455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.48595476s","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:526"} {"level":"warn","ts":"2026-05-19T18:30:48.73464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.021265143s","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-05-19T18:30:48.734672Z","caller":"traceutil/trace.go:171","msg":"trace[438402306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1361; }","duration":"2.021330424s","start":"2026-05-19T18:30:46.713332Z","end":"2026-05-19T18:30:48.734662Z","steps":["trace[438402306] 'agreement among raft nodes before linearized reading' (duration: 2.020934633s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.734654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.85747505s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T18:30:48.734714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.713316Z","time spent":"2.021372605s","remote":"127.0.0.1:57096","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":"info","ts":"2026-05-19T18:30:48.734723Z","caller":"traceutil/trace.go:171","msg":"trace[977195153] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1361; }","duration":"1.857578463s","start":"2026-05-19T18:30:46.877126Z","end":"2026-05-19T18:30:48.734705Z","steps":["trace[977195153] 'agreement among raft nodes before linearized reading' (duration: 1.85745533s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.734778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.877112Z","time spent":"1.857650455s","remote":"127.0.0.1:56964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":29,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:30:48.734789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.086512097s","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-05-19T18:30:48.734826Z","caller":"traceutil/trace.go:171","msg":"trace[276811539] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1361; }","duration":"2.086587729s","start":"2026-05-19T18:30:46.64823Z","end":"2026-05-19T18:30:48.734818Z","steps":["trace[276811539] 'agreement among raft nodes before linearized reading' (duration: 2.086470046s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.734826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.642343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:30:48.734859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.64821Z","time spent":"2.086641551s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-19T18:30:48.734862Z","caller":"traceutil/trace.go:171","msg":"trace[250957480] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1361; }","duration":"243.716845ms","start":"2026-05-19T18:30:48.491136Z","end":"2026-05-19T18:30:48.734853Z","steps":["trace[250957480] 'agreement among raft nodes before linearized reading' (duration: 243.667604ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.734892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.26432809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-19T18:30:48.734916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.021160988s","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-05-19T18:30:48.734951Z","caller":"traceutil/trace.go:171","msg":"trace[1796295235] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1361; }","duration":"2.264417181s","start":"2026-05-19T18:30:46.470512Z","end":"2026-05-19T18:30:48.734929Z","steps":["trace[1796295235] 'agreement among raft nodes before linearized reading' (duration: 2.264255677s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.734961Z","caller":"traceutil/trace.go:171","msg":"trace[799582186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1361; }","duration":"2.02120523s","start":"2026-05-19T18:30:46.713746Z","end":"2026-05-19T18:30:48.734951Z","steps":["trace[799582186] 'agreement among raft nodes before linearized reading' (duration: 2.021100407s)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.734667Z","caller":"traceutil/trace.go:171","msg":"trace[1314517768] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1361; }","duration":"2.486099935s","start":"2026-05-19T18:30:46.248517Z","end":"2026-05-19T18:30:48.734617Z","steps":["trace[1314517768] 'agreement among raft nodes before linearized reading' (duration: 2.485837498s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.734995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.470492Z","time spent":"2.264491553s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-19T18:30:48.735032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.248493Z","time spent":"2.486523595s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-05-19T18:30:48.735034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"901.572272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T18:30:48.735057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.606676268s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-19T18:30:48.734589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:47.407843Z","time spent":"1.326739046s","remote":"127.0.0.1:56808","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-05-19T18:30:48.735109Z","caller":"traceutil/trace.go:171","msg":"trace[342943227] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1361; }","duration":"901.691745ms","start":"2026-05-19T18:30:47.833398Z","end":"2026-05-19T18:30:48.735089Z","steps":["trace[342943227] 'agreement among raft nodes before linearized reading' (duration: 901.548621ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.735112Z","caller":"traceutil/trace.go:171","msg":"trace[134673812] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1361; }","duration":"1.60677548s","start":"2026-05-19T18:30:47.128321Z","end":"2026-05-19T18:30:48.735096Z","steps":["trace[134673812] 'agreement among raft nodes before linearized reading' (duration: 1.606587405s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.735141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.021422845s","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-05-19T18:30:48.735161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:47.83338Z","time spent":"901.765286ms","remote":"127.0.0.1:57032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-05-19T18:30:48.735161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:47.128301Z","time spent":"1.606848322s","remote":"127.0.0.1:57096","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-05-19T18:30:48.735172Z","caller":"traceutil/trace.go:171","msg":"trace[576797870] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1361; }","duration":"2.021493287s","start":"2026-05-19T18:30:46.71367Z","end":"2026-05-19T18:30:48.735163Z","steps":["trace[576797870] 'agreement among raft nodes before linearized reading' (duration: 2.021390744s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.735217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.713649Z","time spent":"2.021561729s","remote":"127.0.0.1:57096","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-05-19T18:30:48.735004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T18:30:46.713679Z","time spent":"2.021314333s","remote":"127.0.0.1:57096","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-05-19T18:30:48.847473Z","caller":"traceutil/trace.go:171","msg":"trace[1562597503] transaction","detail":"{read_only:false; response_revision:1362; number_of_response:1; }","duration":"108.51676ms","start":"2026-05-19T18:30:48.738936Z","end":"2026-05-19T18:30:48.847453Z","steps":["trace[1562597503] 'process raft request' (duration: 108.395687ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.857976Z","caller":"traceutil/trace.go:171","msg":"trace[186187781] transaction","detail":"{read_only:false; response_revision:1363; number_of_response:1; }","duration":"116.45908ms","start":"2026-05-19T18:30:48.741494Z","end":"2026-05-19T18:30:48.857953Z","steps":["trace[186187781] 'process raft request' (duration: 116.232804ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.858723Z","caller":"traceutil/trace.go:171","msg":"trace[1482744754] transaction","detail":"{read_only:false; response_revision:1364; number_of_response:1; }","duration":"117.040545ms","start":"2026-05-19T18:30:48.741668Z","end":"2026-05-19T18:30:48.858708Z","steps":["trace[1482744754] 'process raft request' (duration: 116.250355ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.859104Z","caller":"traceutil/trace.go:171","msg":"trace[351715309] transaction","detail":"{read_only:false; response_revision:1365; number_of_response:1; }","duration":"117.349833ms","start":"2026-05-19T18:30:48.741742Z","end":"2026-05-19T18:30:48.859092Z","steps":["trace[351715309] 'process raft request' (duration: 116.896682ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.859536Z","caller":"traceutil/trace.go:171","msg":"trace[1693640488] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"117.542798ms","start":"2026-05-19T18:30:48.741972Z","end":"2026-05-19T18:30:48.859515Z","steps":["trace[1693640488] 'process raft request' (duration: 116.964693ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.860116Z","caller":"traceutil/trace.go:171","msg":"trace[236120895] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"117.859808ms","start":"2026-05-19T18:30:48.742236Z","end":"2026-05-19T18:30:48.860096Z","steps":["trace[236120895] 'process raft request' (duration: 117.158889ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:30:48.860321Z","caller":"traceutil/trace.go:171","msg":"trace[1480418944] linearizableReadLoop","detail":"{readStateIndex:1424; appliedIndex:1417; }","duration":"117.284021ms","start":"2026-05-19T18:30:48.743024Z","end":"2026-05-19T18:30:48.860308Z","steps":["trace[1480418944] 'read index received' (duration: 104.34406ms)","trace[1480418944] 'applied index is now lower than readState.Index' (duration: 12.938961ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:30:48.860481Z","caller":"traceutil/trace.go:171","msg":"trace[1423291084] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"117.454725ms","start":"2026-05-19T18:30:48.743013Z","end":"2026-05-19T18:30:48.860468Z","steps":["trace[1423291084] 'process raft request' (duration: 116.912952ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:30:48.860673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.640651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:30:48.860733Z","caller":"traceutil/trace.go:171","msg":"trace[310394632] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1368; }","duration":"117.710293ms","start":"2026-05-19T18:30:48.743012Z","end":"2026-05-19T18:30:48.860722Z","steps":["trace[310394632] 'agreement among raft nodes before linearized reading' (duration: 117.61551ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:07.144914Z","caller":"traceutil/trace.go:171","msg":"trace[1765985972] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"122.312663ms","start":"2026-05-19T18:31:07.022558Z","end":"2026-05-19T18:31:07.14487Z","steps":["trace[1765985972] 'process raft request' (duration: 120.092324ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:07.144945Z","caller":"traceutil/trace.go:171","msg":"trace[1355482193] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"121.890632ms","start":"2026-05-19T18:31:07.023012Z","end":"2026-05-19T18:31:07.144903Z","steps":["trace[1355482193] 'process raft request' (duration: 121.731468ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:35.425844Z","caller":"traceutil/trace.go:171","msg":"trace[1749072508] linearizableReadLoop","detail":"{readStateIndex:1659; appliedIndex:1657; }","duration":"107.451697ms","start":"2026-05-19T18:31:35.318368Z","end":"2026-05-19T18:31:35.42582Z","steps":["trace[1749072508] 'read index received' (duration: 41.635047ms)","trace[1749072508] 'applied index is now lower than readState.Index' (duration: 65.81561ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:31:35.426056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.663754ms","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-05-19T18:31:35.42609Z","caller":"traceutil/trace.go:171","msg":"trace[809469061] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1593; }","duration":"107.756357ms","start":"2026-05-19T18:31:35.318322Z","end":"2026-05-19T18:31:35.426078Z","steps":["trace[809469061] 'agreement among raft nodes before linearized reading' (duration: 107.607762ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:35.426233Z","caller":"traceutil/trace.go:171","msg":"trace[832923592] transaction","detail":"{read_only:false; response_revision:1593; number_of_response:1; }","duration":"152.464375ms","start":"2026-05-19T18:31:35.273755Z","end":"2026-05-19T18:31:35.426219Z","steps":["trace[832923592] 'process raft request' (duration: 151.936521ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:57.822023Z","caller":"traceutil/trace.go:171","msg":"trace[1810142787] transaction","detail":"{read_only:false; response_revision:1692; number_of_response:1; }","duration":"207.471798ms","start":"2026-05-19T18:31:57.61452Z","end":"2026-05-19T18:31:57.821992Z","steps":["trace[1810142787] 'process raft request' (duration: 207.288403ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:57.857629Z","caller":"traceutil/trace.go:171","msg":"trace[855448355] transaction","detail":"{read_only:false; response_revision:1694; number_of_response:1; }","duration":"242.407937ms","start":"2026-05-19T18:31:57.615191Z","end":"2026-05-19T18:31:57.857599Z","steps":["trace[855448355] 'process raft request' (duration: 242.301875ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:57.857705Z","caller":"traceutil/trace.go:171","msg":"trace[1270465757] transaction","detail":"{read_only:false; response_revision:1693; number_of_response:1; }","duration":"242.684465ms","start":"2026-05-19T18:31:57.614973Z","end":"2026-05-19T18:31:57.857657Z","steps":["trace[1270465757] 'process raft request' (duration: 242.362307ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:57.857802Z","caller":"traceutil/trace.go:171","msg":"trace[164592391] transaction","detail":"{read_only:false; response_revision:1695; number_of_response:1; }","duration":"121.522893ms","start":"2026-05-19T18:31:57.736259Z","end":"2026-05-19T18:31:57.857782Z","steps":["trace[164592391] 'process raft request' (duration: 121.290286ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:31:57.857661Z","caller":"traceutil/trace.go:171","msg":"trace[1212066753] linearizableReadLoop","detail":"{readStateIndex:1764; appliedIndex:1762; }","duration":"218.057409ms","start":"2026-05-19T18:31:57.639584Z","end":"2026-05-19T18:31:57.857641Z","steps":["trace[1212066753] 'read index received' (duration: 182.415901ms)","trace[1212066753] 'applied index is now lower than readState.Index' (duration: 35.640018ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:31:57.858015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.41294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T18:31:57.858085Z","caller":"traceutil/trace.go:171","msg":"trace[1618882890] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1695; }","duration":"218.527512ms","start":"2026-05-19T18:31:57.639543Z","end":"2026-05-19T18:31:57.85807Z","steps":["trace[1618882890] 'agreement among raft nodes before linearized reading' (duration: 218.154792ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:32:27.901502Z","caller":"traceutil/trace.go:171","msg":"trace[625949143] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"224.408656ms","start":"2026-05-19T18:32:27.677077Z","end":"2026-05-19T18:32:27.901486Z","steps":["trace[625949143] 'read index received' (duration: 224.262792ms)","trace[625949143] 'applied index is now lower than readState.Index' (duration: 145.204µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:32:27.901557Z","caller":"traceutil/trace.go:171","msg":"trace[1305902919] transaction","detail":"{read_only:false; response_revision:1828; number_of_response:1; }","duration":"224.776406ms","start":"2026-05-19T18:32:27.676751Z","end":"2026-05-19T18:32:27.901527Z","steps":["trace[1305902919] 'process raft request' (duration: 224.628902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T18:32:27.901731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.637592ms","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-05-19T18:32:27.9018Z","caller":"traceutil/trace.go:171","msg":"trace[1140291225] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1828; }","duration":"224.755505ms","start":"2026-05-19T18:32:27.677031Z","end":"2026-05-19T18:32:27.901786Z","steps":["trace[1140291225] 'agreement among raft nodes before linearized reading' (duration: 224.534969ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:32:28.22916Z","caller":"traceutil/trace.go:171","msg":"trace[2082025997] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"105.897041ms","start":"2026-05-19T18:32:28.123238Z","end":"2026-05-19T18:32:28.229135Z","steps":["trace[2082025997] 'process raft request' (duration: 94.895131ms)","trace[2082025997] 'compare' (duration: 10.884327ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:32:50.211162Z","caller":"traceutil/trace.go:171","msg":"trace[1438359537] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"102.761878ms","start":"2026-05-19T18:32:50.108371Z","end":"2026-05-19T18:32:50.211133Z","steps":["trace[1438359537] 'process raft request' (duration: 66.061597ms)","trace[1438359537] 'compare' (duration: 36.256549ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:34:04.457144Z","caller":"traceutil/trace.go:171","msg":"trace[905662267] transaction","detail":"{read_only:false; response_revision:2300; number_of_response:1; }","duration":"137.995062ms","start":"2026-05-19T18:34:04.319108Z","end":"2026-05-19T18:34:04.457103Z","steps":["trace[905662267] 'process raft request' (duration: 137.792877ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:34:04.71164Z","caller":"traceutil/trace.go:171","msg":"trace[697632163] linearizableReadLoop","detail":"{readStateIndex:2400; appliedIndex:2399; }","duration":"124.880507ms","start":"2026-05-19T18:34:04.58673Z","end":"2026-05-19T18:34:04.71161Z","steps":["trace[697632163] 'read index received' (duration: 108.603029ms)","trace[697632163] 'applied index is now lower than readState.Index' (duration: 16.276328ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T18:34:04.711918Z","caller":"traceutil/trace.go:171","msg":"trace[823263805] transaction","detail":"{read_only:false; response_revision:2303; number_of_response:1; }","duration":"182.840963ms","start":"2026-05-19T18:34:04.529037Z","end":"2026-05-19T18:34:04.711878Z","steps":["trace[823263805] 'process raft request' (duration: 166.215265ms)","trace[823263805] 'compare' (duration: 16.226058ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T18:34:04.712164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.878871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-05-19T18:34:04.712221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.488684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-05-19T18:34:04.712286Z","caller":"traceutil/trace.go:171","msg":"trace[1384846570] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2303; }","duration":"125.610097ms","start":"2026-05-19T18:34:04.586662Z","end":"2026-05-19T18:34:04.712272Z","steps":["trace[1384846570] 'agreement among raft nodes before linearized reading' (duration: 125.207785ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T18:34:04.712341Z","caller":"traceutil/trace.go:171","msg":"trace[2010198798] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2303; }","duration":"124.030434ms","start":"2026-05-19T18:34:04.588224Z","end":"2026-05-19T18:34:04.712254Z","steps":["trace[2010198798] 'agreement among raft nodes before linearized reading' (duration: 123.674304ms)"],"step_count":1}