{"level":"warn","ts":"2026-05-05T10:19:21.982849Z","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-05T10:19:21.982966Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.243: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.19.213.243:2380","--initial-cluster=instance=https://199.19.213.243:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.243:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.243: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-05T10:19:21.983067Z","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-05T10:19:21.983085Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-05-05T10:19:21.98312Z","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-05T10:19:21.984017Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"]} {"level":"info","ts":"2026-05-05T10:19:21.984111Z","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.19.213.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.243: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-05T10:19:21.98848Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.099966ms"} {"level":"info","ts":"2026-05-05T10:19:22.003805Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"864e14457b828f9c","cluster-id":"6c0ae60a355554b9"} {"level":"info","ts":"2026-05-05T10:19:22.004071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T10:19:22.004217Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 0"} {"level":"info","ts":"2026-05-05T10:19:22.0043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 864e14457b828f9c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T10:19:22.004324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became follower at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.004522Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"warn","ts":"2026-05-05T10:19:22.015525Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T10:19:22.017107Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T10:19:22.018468Z","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-05T10:19:22.020724Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"864e14457b828f9c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T10:19:22.020977Z","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-05T10:19:22.021007Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"864e14457b828f9c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T10:19:22.021068Z","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-05T10:19:22.02108Z","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-05T10:19:22.025247Z","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-05T10:19:22.025432Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"864e14457b828f9c","initial-advertise-peer-urls":["https://199.19.213.243:2380"],"listen-peer-urls":["https://199.19.213.243:2380"],"advertise-client-urls":["https://199.19.213.243:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.243:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T10:19:22.02547Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T10:19:22.026081Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-05-05T10:19:22.026107Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.243:2380"} {"level":"info","ts":"2026-05-05T10:19:22.023778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c switched to configuration voters=(9677694937923227548)"} {"level":"info","ts":"2026-05-05T10:19:22.026214Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","added-peer-id":"864e14457b828f9c","added-peer-peer-urls":["https://199.19.213.243:2380"]} {"level":"info","ts":"2026-05-05T10:19:22.805233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.805484Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.805603Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgPreVoteResp from 864e14457b828f9c at term 1"} {"level":"info","ts":"2026-05-05T10:19:22.80571Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became candidate at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.805811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c received MsgVoteResp from 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.805896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"864e14457b828f9c became leader at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.805981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 864e14457b828f9c elected leader 864e14457b828f9c at term 2"} {"level":"info","ts":"2026-05-05T10:19:22.810773Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.811619Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:19:22.811621Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"864e14457b828f9c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.243:2379]}","request-path":"/0/members/864e14457b828f9c/attributes","cluster-id":"6c0ae60a355554b9","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T10:19:22.81196Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6c0ae60a355554b9","local-member-id":"864e14457b828f9c","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.812118Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.812242Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T10:19:22.812321Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T10:19:22.81487Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T10:19:22.815053Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.243:2379"} {"level":"info","ts":"2026-05-05T10:19:22.815369Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T10:19:22.815427Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"warn","ts":"2026-05-05T10:19:28.053934Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762520076,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T10:19:28.559061Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762520076,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T10:19:29.059623Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762520076,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T10:19:29.062849Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.509347141s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-05T10:19:29.247647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.818996328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:29.247786Z","caller":"traceutil/trace.go:171","msg":"trace[1290213096] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:222; }","duration":"1.819174002s","start":"2026-05-05T10:19:27.428556Z","end":"2026-05-05T10:19:29.24773Z","steps":["trace[1290213096] 'range keys from in-memory index tree' (duration: 1.818918237s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.247847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.428539Z","time spent":"1.819296175s","remote":"127.0.0.1:38500","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"warn","ts":"2026-05-05T10:19:29.248292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.694813698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:29.248434Z","caller":"traceutil/trace.go:171","msg":"trace[259557055] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:222; }","duration":"1.694986322s","start":"2026-05-05T10:19:27.553407Z","end":"2026-05-05T10:19:29.248394Z","steps":["trace[259557055] 'range keys from in-memory index tree' (duration: 1.694640074s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.248539Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.553386Z","time spent":"1.695140506s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-05-05T10:19:29.2487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.296353ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-05-05T10:19:29.248824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.553386Z","time spent":"1.695433103s","remote":"127.0.0.1:38100","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-05T10:19:29.249513Z","caller":"traceutil/trace.go:171","msg":"trace[726781269] linearizableReadLoop","detail":"{readStateIndex:234; appliedIndex:227; }","duration":"1.695921833s","start":"2026-05-05T10:19:27.553572Z","end":"2026-05-05T10:19:29.249494Z","steps":["trace[726781269] 'read index received' (duration: 1.509549406s)","trace[726781269] 'applied index is now lower than readState.Index' (duration: 186.371417ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:29.249565Z","caller":"traceutil/trace.go:171","msg":"trace[701413926] transaction","detail":"{read_only:false; number_of_response:0; response_revision:222; }","duration":"1.59630091s","start":"2026-05-05T10:19:27.653248Z","end":"2026-05-05T10:19:29.249549Z","steps":["trace[701413926] 'process raft request' (duration: 1.595927871s)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.249695Z","caller":"traceutil/trace.go:171","msg":"trace[1087949555] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"1.579385613s","start":"2026-05-05T10:19:27.670296Z","end":"2026-05-05T10:19:29.249682Z","steps":["trace[1087949555] 'process raft request' (duration: 1.578952143s)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.249811Z","caller":"traceutil/trace.go:171","msg":"trace[1282476663] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"1.579362183s","start":"2026-05-05T10:19:27.670441Z","end":"2026-05-05T10:19:29.249804Z","steps":["trace[1282476663] 'process raft request' (duration: 1.578876711s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.250154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.122899435s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:29.250204Z","caller":"traceutil/trace.go:171","msg":"trace[1289716522] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:224; }","duration":"1.123007008s","start":"2026-05-05T10:19:28.127186Z","end":"2026-05-05T10:19:29.250193Z","steps":["trace[1289716522] 'agreement among raft nodes before linearized reading' (duration: 1.122916996s)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.249938Z","caller":"traceutil/trace.go:171","msg":"trace[950630985] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"1.579290571s","start":"2026-05-05T10:19:27.670614Z","end":"2026-05-05T10:19:29.249905Z","steps":["trace[950630985] 'process raft request' (duration: 1.578781279s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.250237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:28.127166Z","time spent":"1.123063669s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T10:19:29.249982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.282888904s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:29.250471Z","caller":"traceutil/trace.go:171","msg":"trace[590907949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:224; }","duration":"1.283426887s","start":"2026-05-05T10:19:27.967032Z","end":"2026-05-05T10:19:29.250459Z","steps":["trace[590907949] 'agreement among raft nodes before linearized reading' (duration: 1.282869874s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.250549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.967003Z","time spent":"1.28353449s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T10:19:29.250602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.653228Z","time spent":"1.596416442s","remote":"127.0.0.1:38202","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:29.249984Z","caller":"traceutil/trace.go:171","msg":"trace[338986750] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"1.579441924s","start":"2026-05-05T10:19:27.670511Z","end":"2026-05-05T10:19:29.249953Z","steps":["trace[338986750] 'process raft request' (duration: 1.578865041s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.251886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.670475Z","time spent":"1.58138204s","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T10:19:29.250036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.6965885s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-05T10:19:29.250046Z","caller":"traceutil/trace.go:171","msg":"trace[645381984] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"1.579548517s","start":"2026-05-05T10:19:27.67049Z","end":"2026-05-05T10:19:29.250038Z","steps":["trace[645381984] 'process raft request' (duration: 1.578862081s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.250076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.694709ms","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-05T10:19:29.250107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.086777199s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:19:29.251167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.670271Z","time spent":"1.579496836s","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5882,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T10:19:29.251205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.670426Z","time spent":"1.579730461s","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T10:19:29.25125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.670598Z","time spent":"1.579767032s","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:29.252055Z","caller":"traceutil/trace.go:171","msg":"trace[2072595252] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:224; }","duration":"1.698621087s","start":"2026-05-05T10:19:27.55342Z","end":"2026-05-05T10:19:29.252041Z","steps":["trace[2072595252] 'agreement among raft nodes before linearized reading' (duration: 1.696586059s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.252594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.553409Z","time spent":"1.69917574s","remote":"127.0.0.1:38414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-05T10:19:29.252103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:27.670471Z","time spent":"1.581613055s","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:29.252281Z","caller":"traceutil/trace.go:171","msg":"trace[1040593633] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:224; }","duration":"227.929202ms","start":"2026-05-05T10:19:29.024343Z","end":"2026-05-05T10:19:29.252272Z","steps":["trace[1040593633] 'agreement among raft nodes before linearized reading' (duration: 225.7099ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.252501Z","caller":"traceutil/trace.go:171","msg":"trace[781742635] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:224; }","duration":"1.089194896s","start":"2026-05-05T10:19:28.163286Z","end":"2026-05-05T10:19:29.252481Z","steps":["trace[781742635] 'agreement among raft nodes before linearized reading' (duration: 1.086806139s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.253089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:28.163268Z","time spent":"1.08981162s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-05T10:19:29.48805Z","caller":"traceutil/trace.go:171","msg":"trace[1218671024] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"159.250212ms","start":"2026-05-05T10:19:29.328769Z","end":"2026-05-05T10:19:29.488019Z","steps":["trace[1218671024] 'process raft request' (duration: 72.667113ms)","trace[1218671024] 'compare' (duration: 86.431206ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:29.488492Z","caller":"traceutil/trace.go:171","msg":"trace[957831881] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"158.910234ms","start":"2026-05-05T10:19:29.329552Z","end":"2026-05-05T10:19:29.488462Z","steps":["trace[957831881] 'process raft request' (duration: 158.678368ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.488488Z","caller":"traceutil/trace.go:171","msg":"trace[740320523] transaction","detail":"{read_only:false; response_revision:235; number_of_response:1; }","duration":"157.397359ms","start":"2026-05-05T10:19:29.33105Z","end":"2026-05-05T10:19:29.488447Z","steps":["trace[740320523] 'process raft request' (duration: 157.306686ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.488597Z","caller":"traceutil/trace.go:171","msg":"trace[2018866868] linearizableReadLoop","detail":"{readStateIndex:244; appliedIndex:242; }","duration":"158.969806ms","start":"2026-05-05T10:19:29.329607Z","end":"2026-05-05T10:19:29.488577Z","steps":["trace[2018866868] 'read index received' (duration: 71.818453ms)","trace[2018866868] 'applied index is now lower than readState.Index' (duration: 87.150043ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:29.488709Z","caller":"traceutil/trace.go:171","msg":"trace[1685172556] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"148.808757ms","start":"2026-05-05T10:19:29.33989Z","end":"2026-05-05T10:19:29.488699Z","steps":["trace[1685172556] 'process raft request' (duration: 148.591262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.488799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.374745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-05T10:19:29.488853Z","caller":"traceutil/trace.go:171","msg":"trace[116370096] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:239; }","duration":"159.457827ms","start":"2026-05-05T10:19:29.32938Z","end":"2026-05-05T10:19:29.488838Z","steps":["trace[116370096] 'agreement among raft nodes before linearized reading' (duration: 159.354524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.488865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.097812ms","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-05T10:19:29.488903Z","caller":"traceutil/trace.go:171","msg":"trace[758486527] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:239; }","duration":"160.183404ms","start":"2026-05-05T10:19:29.328709Z","end":"2026-05-05T10:19:29.488892Z","steps":["trace[758486527] 'agreement among raft nodes before linearized reading' (duration: 160.105842ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.489013Z","caller":"traceutil/trace.go:171","msg":"trace[1204174785] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"147.353033ms","start":"2026-05-05T10:19:29.341643Z","end":"2026-05-05T10:19:29.488996Z","steps":["trace[1204174785] 'process raft request' (duration: 146.883552ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.489036Z","caller":"traceutil/trace.go:171","msg":"trace[432002217] transaction","detail":"{read_only:false; response_revision:237; number_of_response:1; }","duration":"155.248838ms","start":"2026-05-05T10:19:29.333773Z","end":"2026-05-05T10:19:29.489022Z","steps":["trace[432002217] 'process raft request' (duration: 154.650834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.489112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.187111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:29.489166Z","caller":"traceutil/trace.go:171","msg":"trace[1777870770] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:239; }","duration":"156.293733ms","start":"2026-05-05T10:19:29.332858Z","end":"2026-05-05T10:19:29.489152Z","steps":["trace[1777870770] 'agreement among raft nodes before linearized reading' (duration: 156.187001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:29.48923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.04231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:29.489263Z","caller":"traceutil/trace.go:171","msg":"trace[305715378] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:239; }","duration":"148.085ms","start":"2026-05-05T10:19:29.341167Z","end":"2026-05-05T10:19:29.489252Z","steps":["trace[305715378] 'agreement among raft nodes before linearized reading' (duration: 148.036129ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:29.489251Z","caller":"traceutil/trace.go:171","msg":"trace[1136948381] transaction","detail":"{read_only:false; response_revision:236; number_of_response:1; }","duration":"155.128745ms","start":"2026-05-05T10:19:29.333768Z","end":"2026-05-05T10:19:29.488897Z","steps":["trace[1136948381] 'process raft request' (duration: 154.620653ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:34.12549Z","caller":"traceutil/trace.go:171","msg":"trace[2075552540] transaction","detail":"{read_only:false; response_revision:306; number_of_response:1; }","duration":"124.799604ms","start":"2026-05-05T10:19:34.000653Z","end":"2026-05-05T10:19:34.125453Z","steps":["trace[2075552540] 'process raft request' (duration: 124.450966ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:34.894731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762520292,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T10:19:35.290887Z","caller":"traceutil/trace.go:171","msg":"trace[809657866] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"938.864803ms","start":"2026-05-05T10:19:34.351997Z","end":"2026-05-05T10:19:35.290862Z","steps":["trace[809657866] 'process raft request' (duration: 938.74346ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:35.291019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.351971Z","time spent":"938.989986ms","remote":"127.0.0.1:38552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T10:19:35.720783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.224538ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:19:35.720916Z","caller":"traceutil/trace.go:171","msg":"trace[170240917] linearizableReadLoop","detail":"{readStateIndex:322; appliedIndex:320; }","duration":"1.327253204s","start":"2026-05-05T10:19:34.393646Z","end":"2026-05-05T10:19:35.720899Z","steps":["trace[170240917] 'read index received' (duration: 897.074923ms)","trace[170240917] 'applied index is now lower than readState.Index' (duration: 430.176391ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:35.721002Z","caller":"traceutil/trace.go:171","msg":"trace[1032459096] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"1.112506452s","start":"2026-05-05T10:19:34.608478Z","end":"2026-05-05T10:19:35.720984Z","steps":["trace[1032459096] 'process raft request' (duration: 755.6928ms)","trace[1032459096] 'compare' (duration: 356.075465ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:19:35.721047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.327398348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-05-05T10:19:35.721075Z","caller":"traceutil/trace.go:171","msg":"trace[1443703048] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:312; }","duration":"1.327427329s","start":"2026-05-05T10:19:34.393638Z","end":"2026-05-05T10:19:35.721065Z","steps":["trace[1443703048] 'agreement among raft nodes before linearized reading' (duration: 1.327344007s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:35.721104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.608445Z","time spent":"1.112605075s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:19:35.721115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.393582Z","time spent":"1.327524471s","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-05-05T10:19:36.282858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.947286ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:19:36.283121Z","caller":"traceutil/trace.go:171","msg":"trace[656921383] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"550.373078ms","start":"2026-05-05T10:19:35.732731Z","end":"2026-05-05T10:19:36.283104Z","steps":["trace[656921383] 'process raft request' (duration: 550.332677ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.283211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.732708Z","time spent":"550.45654ms","remote":"127.0.0.1:38374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2094,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:19:36.283332Z","caller":"traceutil/trace.go:171","msg":"trace[1270765789] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"550.729917ms","start":"2026-05-05T10:19:35.732594Z","end":"2026-05-05T10:19:36.283323Z","steps":["trace[1270765789] 'process raft request' (duration: 550.365948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.283377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.732569Z","time spent":"550.782987ms","remote":"127.0.0.1:38374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":899,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:19:36.283459Z","caller":"traceutil/trace.go:171","msg":"trace[1912888844] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"987.222106ms","start":"2026-05-05T10:19:35.296203Z","end":"2026-05-05T10:19:36.283425Z","steps":["trace[1912888844] 'process raft request' (duration: 582.651705ms)","trace[1912888844] 'compare' (duration: 403.780963ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:36.283604Z","caller":"traceutil/trace.go:171","msg":"trace[299568121] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"550.89707ms","start":"2026-05-05T10:19:35.732692Z","end":"2026-05-05T10:19:36.283589Z","steps":["trace[299568121] 'process raft request' (duration: 550.339527ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.283608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.296177Z","time spent":"987.357549ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3378,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T10:19:36.283675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.732685Z","time spent":"550.954032ms","remote":"127.0.0.1:38374","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2191,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:19:36.284007Z","caller":"traceutil/trace.go:171","msg":"trace[2068484604] linearizableReadLoop","detail":"{readStateIndex:323; appliedIndex:322; }","duration":"563.028314ms","start":"2026-05-05T10:19:35.72096Z","end":"2026-05-05T10:19:36.283988Z","steps":["trace[2068484604] 'read index received' (duration: 157.950271ms)","trace[2068484604] 'applied index is now lower than readState.Index' (duration: 405.075883ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:19:36.28412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"788.932109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:19:36.284167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"920.023351ms","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-05T10:19:36.284216Z","caller":"traceutil/trace.go:171","msg":"trace[172616114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:316; }","duration":"920.112293ms","start":"2026-05-05T10:19:35.36409Z","end":"2026-05-05T10:19:36.284203Z","steps":["trace[172616114] 'agreement among raft nodes before linearized reading' (duration: 920.008031ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.284259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.364068Z","time spent":"920.182295ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T10:19:36.284412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"733.221163ms","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-05T10:19:36.28447Z","caller":"traceutil/trace.go:171","msg":"trace[2070203802] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:316; }","duration":"733.300155ms","start":"2026-05-05T10:19:35.551156Z","end":"2026-05-05T10:19:36.284456Z","steps":["trace[2070203802] 'agreement among raft nodes before linearized reading' (duration: 733.202593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.284503Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.790257135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-05-05T10:19:36.284519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.551144Z","time spent":"733.364897ms","remote":"127.0.0.1:38280","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-05T10:19:36.284496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.74053919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-05-05T10:19:36.284614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.84081827s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-05-05T10:19:36.28462Z","caller":"traceutil/trace.go:171","msg":"trace[696210871] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:316; }","duration":"1.740726814s","start":"2026-05-05T10:19:34.543859Z","end":"2026-05-05T10:19:36.284586Z","steps":["trace[696210871] 'agreement among raft nodes before linearized reading' (duration: 1.740440188s)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:36.28466Z","caller":"traceutil/trace.go:171","msg":"trace[1045199308] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:316; }","duration":"1.840898922s","start":"2026-05-05T10:19:34.44375Z","end":"2026-05-05T10:19:36.284649Z","steps":["trace[1045199308] 'agreement among raft nodes before linearized reading' (duration: 1.84082989s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.284682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.543836Z","time spent":"1.740835576s","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-05-05T10:19:36.284711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.443729Z","time spent":"1.840969084s","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-05-05T10:19:36.284768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.690802414s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-05-05T10:19:36.28479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.640355672s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-05-05T10:19:36.284554Z","caller":"traceutil/trace.go:171","msg":"trace[603734379] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:316; }","duration":"1.790348027s","start":"2026-05-05T10:19:34.494192Z","end":"2026-05-05T10:19:36.28454Z","steps":["trace[603734379] 'agreement among raft nodes before linearized reading' (duration: 1.790242425s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.284863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.494168Z","time spent":"1.790688715s","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-05-05T10:19:36.284959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.691384908s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6965"} {"level":"info","ts":"2026-05-05T10:19:36.285051Z","caller":"traceutil/trace.go:171","msg":"trace[694733134] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:316; }","duration":"1.691576913s","start":"2026-05-05T10:19:34.593451Z","end":"2026-05-05T10:19:36.285028Z","steps":["trace[694733134] 'agreement among raft nodes before linearized reading' (duration: 1.691394199s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.285121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"739.185033ms","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-05T10:19:36.285133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.593428Z","time spent":"1.691679705s","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6988,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-05-05T10:19:36.285158Z","caller":"traceutil/trace.go:171","msg":"trace[940345037] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:316; }","duration":"739.254545ms","start":"2026-05-05T10:19:35.545897Z","end":"2026-05-05T10:19:36.285152Z","steps":["trace[940345037] 'agreement among raft nodes before linearized reading' (duration: 739.168843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.285193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.545886Z","time spent":"739.301226ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T10:19:36.285411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.233724ms","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-05T10:19:36.285441Z","caller":"traceutil/trace.go:171","msg":"trace[773614390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:316; }","duration":"771.300705ms","start":"2026-05-05T10:19:35.514132Z","end":"2026-05-05T10:19:36.285433Z","steps":["trace[773614390] 'agreement among raft nodes before linearized reading' (duration: 771.235414ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.285463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.514114Z","time spent":"771.342987ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T10:19:36.284868Z","caller":"traceutil/trace.go:171","msg":"trace[910289469] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:316; }","duration":"1.640480776s","start":"2026-05-05T10:19:34.644369Z","end":"2026-05-05T10:19:36.28485Z","steps":["trace[910289469] 'agreement among raft nodes before linearized reading' (duration: 1.640354443s)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:36.284173Z","caller":"traceutil/trace.go:171","msg":"trace[1269249297] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:316; }","duration":"789.038781ms","start":"2026-05-05T10:19:35.495116Z","end":"2026-05-05T10:19:36.284155Z","steps":["trace[1269249297] 'agreement among raft nodes before linearized reading' (duration: 788.940189ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.285751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.495094Z","time spent":"790.639129ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T10:19:36.284816Z","caller":"traceutil/trace.go:171","msg":"trace[623062903] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:316; }","duration":"1.690875027s","start":"2026-05-05T10:19:34.593927Z","end":"2026-05-05T10:19:36.284802Z","steps":["trace[623062903] 'agreement among raft nodes before linearized reading' (duration: 1.690772834s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.285932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.644333Z","time spent":"1.641588801s","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-05-05T10:19:36.285964Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:34.593918Z","time spent":"1.692035414s","remote":"127.0.0.1:38226","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-05-05T10:19:36.285762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.777926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.243\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T10:19:36.286115Z","caller":"traceutil/trace.go:171","msg":"trace[1115829653] range","detail":"{range_begin:/registry/masterleases/199.19.213.243; range_end:; response_count:1; response_revision:316; }","duration":"565.153105ms","start":"2026-05-05T10:19:35.720946Z","end":"2026-05-05T10:19:36.286099Z","steps":["trace[1115829653] 'agreement among raft nodes before linearized reading' (duration: 564.770336ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:36.28616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:35.720929Z","time spent":"565.218816ms","remote":"127.0.0.1:38066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.243\" "} {"level":"info","ts":"2026-05-05T10:19:46.773206Z","caller":"traceutil/trace.go:171","msg":"trace[559521943] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"414.572226ms","start":"2026-05-05T10:19:46.358611Z","end":"2026-05-05T10:19:46.773183Z","steps":["trace[559521943] 'process raft request' (duration: 414.413172ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:46.773376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:46.3586Z","time spent":"414.686338ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:19:46.895259Z","caller":"traceutil/trace.go:171","msg":"trace[2043224963] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"535.580421ms","start":"2026-05-05T10:19:46.359662Z","end":"2026-05-05T10:19:46.895243Z","steps":["trace[2043224963] 'read index received' (duration: 413.510701ms)","trace[2043224963] 'applied index is now lower than readState.Index' (duration: 122.06893ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:46.895473Z","caller":"traceutil/trace.go:171","msg":"trace[1698697474] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"535.824807ms","start":"2026-05-05T10:19:46.359639Z","end":"2026-05-05T10:19:46.895463Z","steps":["trace[1698697474] 'process raft request' (duration: 535.457639ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:46.895538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:46.359626Z","time spent":"535.870868ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:19:46.895682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.016821ms","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-05T10:19:46.895711Z","caller":"traceutil/trace.go:171","msg":"trace[1523106330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"536.066143ms","start":"2026-05-05T10:19:46.359635Z","end":"2026-05-05T10:19:46.895701Z","steps":["trace[1523106330] 'agreement among raft nodes before linearized reading' (duration: 536.013372ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:46.895738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:46.359624Z","time spent":"536.108094ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-05T10:19:46.895826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.903779ms","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-05T10:19:46.89585Z","caller":"traceutil/trace.go:171","msg":"trace[389721944] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:419; }","duration":"535.97483ms","start":"2026-05-05T10:19:46.359866Z","end":"2026-05-05T10:19:46.895841Z","steps":["trace[389721944] 'agreement among raft nodes before linearized reading' (duration: 535.932929ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:46.895874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:46.35986Z","time spent":"536.007951ms","remote":"127.0.0.1:38280","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-05T10:19:47.150917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.92761ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:19:47.151027Z","caller":"traceutil/trace.go:171","msg":"trace[1276356418] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"250.688385ms","start":"2026-05-05T10:19:46.900321Z","end":"2026-05-05T10:19:47.15101Z","steps":["trace[1276356418] 'process raft request' (duration: 130.595551ms)","trace[1276356418] 'compare' (duration: 119.798657ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:56.308738Z","caller":"traceutil/trace.go:171","msg":"trace[198300725] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"353.145059ms","start":"2026-05-05T10:19:55.955565Z","end":"2026-05-05T10:19:56.30871Z","steps":["trace[198300725] 'process raft request' (duration: 353.006876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.308919Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.955545Z","time spent":"353.291313ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.319868Z","caller":"traceutil/trace.go:171","msg":"trace[144919296] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"197.711592ms","start":"2026-05-05T10:19:56.122135Z","end":"2026-05-05T10:19:56.319847Z","steps":["trace[144919296] 'process raft request' (duration: 197.670071ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:56.319974Z","caller":"traceutil/trace.go:171","msg":"trace[1103262130] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"360.650966ms","start":"2026-05-05T10:19:55.959315Z","end":"2026-05-05T10:19:56.319966Z","steps":["trace[1103262130] 'process raft request' (duration: 359.98391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.959297Z","time spent":"360.694297ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320088Z","caller":"traceutil/trace.go:171","msg":"trace[85702515] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"359.387616ms","start":"2026-05-05T10:19:55.960695Z","end":"2026-05-05T10:19:56.320083Z","steps":["trace[85702515] 'process raft request' (duration: 358.70149ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.960688Z","time spent":"359.411547ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.32016Z","caller":"traceutil/trace.go:171","msg":"trace[1737444686] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"349.894343ms","start":"2026-05-05T10:19:55.97026Z","end":"2026-05-05T10:19:56.320154Z","steps":["trace[1737444686] 'process raft request' (duration: 349.171276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320182Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.970244Z","time spent":"349.927884ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320225Z","caller":"traceutil/trace.go:171","msg":"trace[34698605] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"349.876323ms","start":"2026-05-05T10:19:55.970345Z","end":"2026-05-05T10:19:56.320221Z","steps":["trace[34698605] 'process raft request' (duration: 349.113695ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.970308Z","time spent":"349.933253ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320293Z","caller":"traceutil/trace.go:171","msg":"trace[581397628] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"345.392557ms","start":"2026-05-05T10:19:55.974896Z","end":"2026-05-05T10:19:56.320289Z","steps":["trace[581397628] 'process raft request' (duration: 344.594518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.32032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.974883Z","time spent":"345.425798ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320366Z","caller":"traceutil/trace.go:171","msg":"trace[1233553591] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"345.455128ms","start":"2026-05-05T10:19:55.974905Z","end":"2026-05-05T10:19:56.32036Z","steps":["trace[1233553591] 'process raft request' (duration: 344.610068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.974897Z","time spent":"345.484309ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320434Z","caller":"traceutil/trace.go:171","msg":"trace[1045665384] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"336.61334ms","start":"2026-05-05T10:19:55.983816Z","end":"2026-05-05T10:19:56.320429Z","steps":["trace[1045665384] 'process raft request' (duration: 335.723779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.983797Z","time spent":"336.652671ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320507Z","caller":"traceutil/trace.go:171","msg":"trace[1422733287] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"327.982888ms","start":"2026-05-05T10:19:55.992519Z","end":"2026-05-05T10:19:56.320502Z","steps":["trace[1422733287] 'process raft request' (duration: 327.048636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:55.992501Z","time spent":"328.021928ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320575Z","caller":"traceutil/trace.go:171","msg":"trace[1174443231] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"314.10741ms","start":"2026-05-05T10:19:56.006464Z","end":"2026-05-05T10:19:56.320571Z","steps":["trace[1174443231] 'process raft request' (duration: 313.134967ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.006439Z","time spent":"314.152912ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320647Z","caller":"traceutil/trace.go:171","msg":"trace[1490212786] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"301.543575ms","start":"2026-05-05T10:19:56.019099Z","end":"2026-05-05T10:19:56.320643Z","steps":["trace[1490212786] 'process raft request' (duration: 300.590843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:56.320674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.019075Z","time spent":"301.588256ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:56.320798Z","caller":"traceutil/trace.go:171","msg":"trace[1018978551] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"245.768163ms","start":"2026-05-05T10:19:56.075025Z","end":"2026-05-05T10:19:56.320793Z","steps":["trace[1018978551] 'process raft request' (duration: 244.701358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:57.122663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.566507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:19:57.122875Z","caller":"traceutil/trace.go:171","msg":"trace[1029678854] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"695.987786ms","start":"2026-05-05T10:19:56.42688Z","end":"2026-05-05T10:19:57.122868Z","steps":["trace[1029678854] 'process raft request' (duration: 695.901974ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:57.122862Z","caller":"traceutil/trace.go:171","msg":"trace[884397500] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"697.216196ms","start":"2026-05-05T10:19:56.425624Z","end":"2026-05-05T10:19:57.12284Z","steps":["trace[884397500] 'process raft request' (duration: 697.116213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:57.122928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.426864Z","time spent":"696.037458ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:19:57.12295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.425615Z","time spent":"697.290947ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:19:57.122986Z","caller":"traceutil/trace.go:171","msg":"trace[1476610172] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"700.249387ms","start":"2026-05-05T10:19:56.42272Z","end":"2026-05-05T10:19:57.122969Z","steps":["trace[1476610172] 'process raft request' (duration: 273.334151ms)","trace[1476610172] 'compare' (duration: 426.328862ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:19:57.12308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.4227Z","time spent":"700.330769ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:19:57.123116Z","caller":"traceutil/trace.go:171","msg":"trace[1716303619] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"696.164851ms","start":"2026-05-05T10:19:56.426941Z","end":"2026-05-05T10:19:57.123106Z","steps":["trace[1716303619] 'process raft request' (duration: 695.877234ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:57.123165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.426933Z","time spent":"696.205232ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:19:57.123339Z","caller":"traceutil/trace.go:171","msg":"trace[1148080632] linearizableReadLoop","detail":"{readStateIndex:527; appliedIndex:521; }","duration":"263.159602ms","start":"2026-05-05T10:19:56.860174Z","end":"2026-05-05T10:19:57.123333Z","steps":["trace[1148080632] 'read index received' (duration: 261.565495ms)","trace[1148080632] 'applied index is now lower than readState.Index' (duration: 1.593717ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:57.123362Z","caller":"traceutil/trace.go:171","msg":"trace[1400113029] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"690.791935ms","start":"2026-05-05T10:19:56.432561Z","end":"2026-05-05T10:19:57.123352Z","steps":["trace[1400113029] 'process raft request' (duration: 690.493348ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:57.123379Z","caller":"traceutil/trace.go:171","msg":"trace[1055968461] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"656.392525ms","start":"2026-05-05T10:19:56.466982Z","end":"2026-05-05T10:19:57.123375Z","steps":["trace[1055968461] 'process raft request' (duration: 656.218281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:57.123405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.466963Z","time spent":"656.425806ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:19:57.12341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:19:56.432552Z","time spent":"690.831805ms","remote":"127.0.0.1:38076","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7693,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:19:57.123524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.894903ms","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-05T10:19:57.123528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.357647ms","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-05T10:19:57.123545Z","caller":"traceutil/trace.go:171","msg":"trace[977970056] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:506; }","duration":"125.951214ms","start":"2026-05-05T10:19:56.99759Z","end":"2026-05-05T10:19:57.123541Z","steps":["trace[977970056] 'agreement among raft nodes before linearized reading' (duration: 125.917973ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:57.12356Z","caller":"traceutil/trace.go:171","msg":"trace[1832272749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:506; }","duration":"263.425718ms","start":"2026-05-05T10:19:56.860124Z","end":"2026-05-05T10:19:57.12355Z","steps":["trace[1832272749] 'agreement among raft nodes before linearized reading' (duration: 263.343466ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:57.123595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.825142ms","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-05T10:19:57.123701Z","caller":"traceutil/trace.go:171","msg":"trace[339818048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:506; }","duration":"182.980535ms","start":"2026-05-05T10:19:56.940696Z","end":"2026-05-05T10:19:57.123676Z","steps":["trace[339818048] 'agreement among raft nodes before linearized reading' (duration: 182.73693ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:58.105907Z","caller":"traceutil/trace.go:171","msg":"trace[424712311] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"133.706246ms","start":"2026-05-05T10:19:57.972183Z","end":"2026-05-05T10:19:58.105889Z","steps":["trace[424712311] 'process raft request' (duration: 133.155623ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:58.15026Z","caller":"traceutil/trace.go:171","msg":"trace[522246969] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"138.257513ms","start":"2026-05-05T10:19:58.011985Z","end":"2026-05-05T10:19:58.150242Z","steps":["trace[522246969] 'process raft request' (duration: 137.863714ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:58.384526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.379136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:19:58.384669Z","caller":"traceutil/trace.go:171","msg":"trace[1346853958] linearizableReadLoop","detail":"{readStateIndex:570; appliedIndex:569; }","duration":"202.976796ms","start":"2026-05-05T10:19:58.181647Z","end":"2026-05-05T10:19:58.384624Z","steps":["trace[1346853958] 'read index received' (duration: 30.363844ms)","trace[1346853958] 'applied index is now lower than readState.Index' (duration: 172.611822ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:19:58.384916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.244792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-05-05T10:19:58.385013Z","caller":"traceutil/trace.go:171","msg":"trace[577183962] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:549; }","duration":"203.390146ms","start":"2026-05-05T10:19:58.1816Z","end":"2026-05-05T10:19:58.38499Z","steps":["trace[577183962] 'agreement among raft nodes before linearized reading' (duration: 203.120579ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:58.385337Z","caller":"traceutil/trace.go:171","msg":"trace[819366810] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"221.256936ms","start":"2026-05-05T10:19:58.163415Z","end":"2026-05-05T10:19:58.384671Z","steps":["trace[819366810] 'process raft request' (duration: 48.646815ms)","trace[819366810] 'compare' (duration: 172.259803ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:19:58.386624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.624029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:19:58.386683Z","caller":"traceutil/trace.go:171","msg":"trace[1779807768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:550; }","duration":"123.707061ms","start":"2026-05-05T10:19:58.262957Z","end":"2026-05-05T10:19:58.386664Z","steps":["trace[1779807768] 'agreement among raft nodes before linearized reading' (duration: 123.568258ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:58.643723Z","caller":"traceutil/trace.go:171","msg":"trace[1620903934] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"200.075258ms","start":"2026-05-05T10:19:58.443617Z","end":"2026-05-05T10:19:58.643693Z","steps":["trace[1620903934] 'process raft request' (duration: 113.838319ms)","trace[1620903934] 'compare' (duration: 85.938592ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:58.654244Z","caller":"traceutil/trace.go:171","msg":"trace[1939819366] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"198.969112ms","start":"2026-05-05T10:19:58.455257Z","end":"2026-05-05T10:19:58.654226Z","steps":["trace[1939819366] 'read index received' (duration: 102.286527ms)","trace[1939819366] 'applied index is now lower than readState.Index' (duration: 96.682015ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:19:58.654286Z","caller":"traceutil/trace.go:171","msg":"trace[1741180597] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"210.189346ms","start":"2026-05-05T10:19:58.444071Z","end":"2026-05-05T10:19:58.654261Z","steps":["trace[1741180597] 'process raft request' (duration: 209.988751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:19:58.654455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.166086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-05-05T10:19:58.6545Z","caller":"traceutil/trace.go:171","msg":"trace[1077639789] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:552; }","duration":"199.263019ms","start":"2026-05-05T10:19:58.455226Z","end":"2026-05-05T10:19:58.654489Z","steps":["trace[1077639789] 'agreement among raft nodes before linearized reading' (duration: 199.066574ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:19:59.789513Z","caller":"traceutil/trace.go:171","msg":"trace[370689270] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"144.06912ms","start":"2026-05-05T10:19:59.645413Z","end":"2026-05-05T10:19:59.789482Z","steps":["trace[370689270] 'process raft request' (duration: 143.871645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:01.175388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.245582ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T10:20:01.180567Z","caller":"traceutil/trace.go:171","msg":"trace[1125251153] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"109.585628ms","start":"2026-05-05T10:20:01.070958Z","end":"2026-05-05T10:20:01.180544Z","steps":["trace[1125251153] 'process raft request' (duration: 109.098197ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:02.376445Z","caller":"traceutil/trace.go:171","msg":"trace[1512936764] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"113.349777ms","start":"2026-05-05T10:20:02.263076Z","end":"2026-05-05T10:20:02.376426Z","steps":["trace[1512936764] 'read index received' (duration: 112.63088ms)","trace[1512936764] 'applied index is now lower than readState.Index' (duration: 718.147µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:20:02.376576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.542391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:02.376603Z","caller":"traceutil/trace.go:171","msg":"trace[1599777306] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"113.616703ms","start":"2026-05-05T10:20:02.262978Z","end":"2026-05-05T10:20:02.376595Z","steps":["trace[1599777306] 'agreement among raft nodes before linearized reading' (duration: 113.525531ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:02.376619Z","caller":"traceutil/trace.go:171","msg":"trace[804354144] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"202.909135ms","start":"2026-05-05T10:20:02.173675Z","end":"2026-05-05T10:20:02.376584Z","steps":["trace[804354144] 'process raft request' (duration: 202.29539ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:04.641534Z","caller":"traceutil/trace.go:171","msg":"trace[1214160013] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"241.490712ms","start":"2026-05-05T10:20:04.399986Z","end":"2026-05-05T10:20:04.641477Z","steps":["trace[1214160013] 'read index received' (duration: 235.737117ms)","trace[1214160013] 'applied index is now lower than readState.Index' (duration: 5.752395ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:20:04.641583Z","caller":"traceutil/trace.go:171","msg":"trace[1224425845] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"245.059946ms","start":"2026-05-05T10:20:04.396494Z","end":"2026-05-05T10:20:04.641554Z","steps":["trace[1224425845] 'process raft request' (duration: 239.660529ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.641704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.693497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.641836Z","caller":"traceutil/trace.go:171","msg":"trace[1743737079] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:586; }","duration":"241.83896ms","start":"2026-05-05T10:20:04.399983Z","end":"2026-05-05T10:20:04.641822Z","steps":["trace[1743737079] 'agreement among raft nodes before linearized reading' (duration: 241.671066ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.641934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.868661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:04.642032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.287136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642096Z","caller":"traceutil/trace.go:171","msg":"trace[1484590622] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:586; }","duration":"164.355267ms","start":"2026-05-05T10:20:04.47771Z","end":"2026-05-05T10:20:04.642066Z","steps":["trace[1484590622] 'agreement among raft nodes before linearized reading' (duration: 164.235794ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.642132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.538374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642252Z","caller":"traceutil/trace.go:171","msg":"trace[294178926] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"210.715048ms","start":"2026-05-05T10:20:04.431508Z","end":"2026-05-05T10:20:04.642223Z","steps":["trace[294178926] 'agreement among raft nodes before linearized reading' (duration: 210.459622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.642219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.733048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642307Z","caller":"traceutil/trace.go:171","msg":"trace[84232647] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"210.835731ms","start":"2026-05-05T10:20:04.431456Z","end":"2026-05-05T10:20:04.642292Z","steps":["trace[84232647] 'agreement among raft nodes before linearized reading' (duration: 210.730719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.64241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.952713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642441Z","caller":"traceutil/trace.go:171","msg":"trace[2018343831] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:586; }","duration":"241.999455ms","start":"2026-05-05T10:20:04.400433Z","end":"2026-05-05T10:20:04.642432Z","steps":["trace[2018343831] 'agreement among raft nodes before linearized reading' (duration: 241.952814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.642542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.672677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:04.642603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.96533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642624Z","caller":"traceutil/trace.go:171","msg":"trace[1047518554] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:586; }","duration":"139.80619ms","start":"2026-05-05T10:20:04.502801Z","end":"2026-05-05T10:20:04.642607Z","steps":["trace[1047518554] 'agreement among raft nodes before linearized reading' (duration: 139.663677ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:04.642637Z","caller":"traceutil/trace.go:171","msg":"trace[1402530103] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:586; }","duration":"210.024202ms","start":"2026-05-05T10:20:04.432598Z","end":"2026-05-05T10:20:04.642622Z","steps":["trace[1402530103] 'agreement among raft nodes before linearized reading' (duration: 209.93768ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.642732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.985895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:04.642753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.156076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642773Z","caller":"traceutil/trace.go:171","msg":"trace[1998089626] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:586; }","duration":"165.214678ms","start":"2026-05-05T10:20:04.477553Z","end":"2026-05-05T10:20:04.642767Z","steps":["trace[1998089626] 'agreement among raft nodes before linearized reading' (duration: 165.182027ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:04.642775Z","caller":"traceutil/trace.go:171","msg":"trace[1640402034] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:586; }","duration":"140.045895ms","start":"2026-05-05T10:20:04.502713Z","end":"2026-05-05T10:20:04.642759Z","steps":["trace[1640402034] 'agreement among raft nodes before linearized reading' (duration: 139.987484ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.64279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.301304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642814Z","caller":"traceutil/trace.go:171","msg":"trace[197888527] 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:586; }","duration":"118.381026ms","start":"2026-05-05T10:20:04.524426Z","end":"2026-05-05T10:20:04.642807Z","steps":["trace[197888527] 'agreement among raft nodes before linearized reading' (duration: 118.345245ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:04.642817Z","caller":"traceutil/trace.go:171","msg":"trace[1391075624] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:586; }","duration":"241.933543ms","start":"2026-05-05T10:20:04.400036Z","end":"2026-05-05T10:20:04.64197Z","steps":["trace[1391075624] 'agreement among raft nodes before linearized reading' (duration: 241.785419ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.642908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.757729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.642929Z","caller":"traceutil/trace.go:171","msg":"trace[2143230393] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:586; }","duration":"139.777639ms","start":"2026-05-05T10:20:04.503145Z","end":"2026-05-05T10:20:04.642922Z","steps":["trace[2143230393] 'agreement among raft nodes before linearized reading' (duration: 139.748509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.642991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.514962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:04.643037Z","caller":"traceutil/trace.go:171","msg":"trace[1005383247] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:586; }","duration":"164.598363ms","start":"2026-05-05T10:20:04.478428Z","end":"2026-05-05T10:20:04.643026Z","steps":["trace[1005383247] 'agreement among raft nodes before linearized reading' (duration: 164.371627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:04.644423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.515635ms","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-05T10:20:04.644558Z","caller":"traceutil/trace.go:171","msg":"trace[1201381963] 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:586; }","duration":"120.007834ms","start":"2026-05-05T10:20:04.5245Z","end":"2026-05-05T10:20:04.644508Z","steps":["trace[1201381963] 'agreement among raft nodes before linearized reading' (duration: 117.372542ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.207129Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762520801,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T10:20:05.589727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.191627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tzwxz\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-05-05T10:20:05.590105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.064567438s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.590183Z","caller":"traceutil/trace.go:171","msg":"trace[879680611] 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:586; }","duration":"1.064696241s","start":"2026-05-05T10:20:04.525462Z","end":"2026-05-05T10:20:05.590158Z","steps":["trace[879680611] 'agreement among raft nodes before linearized reading' (duration: 117.968256ms)","trace[879680611] 'range keys from in-memory index tree' (duration: 946.614323ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:20:05.590253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.525442Z","time spent":"1.064801533s","remote":"127.0.0.1:49866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.59034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.627937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:05.590393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.792816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.590414Z","caller":"traceutil/trace.go:171","msg":"trace[1096491191] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:586; }","duration":"933.73736ms","start":"2026-05-05T10:20:04.656654Z","end":"2026-05-05T10:20:05.590392Z","steps":["trace[1096491191] 'count revisions from in-memory index tree' (duration: 933.396942ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:05.590427Z","caller":"traceutil/trace.go:171","msg":"trace[793355113] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:586; }","duration":"906.840516ms","start":"2026-05-05T10:20:04.683575Z","end":"2026-05-05T10:20:05.590416Z","steps":["trace[793355113] 'count revisions from in-memory index tree' (duration: 906.760995ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.590471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.683571Z","time spent":"906.891529ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.590466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.65664Z","time spent":"933.812181ms","remote":"127.0.0.1:49908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.59068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.259136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.590702Z","caller":"traceutil/trace.go:171","msg":"trace[1439302163] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:586; }","duration":"907.315428ms","start":"2026-05-05T10:20:04.683379Z","end":"2026-05-05T10:20:05.590695Z","steps":["trace[1439302163] 'range keys from in-memory index tree' (duration: 907.028211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.590722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.683358Z","time spent":"907.35779ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.590713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.905483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.590807Z","caller":"traceutil/trace.go:171","msg":"trace[1361393588] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:586; }","duration":"934.013536ms","start":"2026-05-05T10:20:04.656781Z","end":"2026-05-05T10:20:05.590795Z","steps":["trace[1361393588] 'range keys from in-memory index tree' (duration: 933.864943ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.590841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.656772Z","time spent":"934.057867ms","remote":"127.0.0.1:49908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.590868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.974156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.590905Z","caller":"traceutil/trace.go:171","msg":"trace[1530572971] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:586; }","duration":"934.029117ms","start":"2026-05-05T10:20:04.656863Z","end":"2026-05-05T10:20:05.590892Z","steps":["trace[1530572971] 'range keys from in-memory index tree' (duration: 933.910994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.590933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.656856Z","time spent":"934.067717ms","remote":"127.0.0.1:49908","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.591109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.53271ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:20:05.591157Z","caller":"traceutil/trace.go:171","msg":"trace[1389709728] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"884.43595ms","start":"2026-05-05T10:20:04.706714Z","end":"2026-05-05T10:20:05.59115Z","steps":["trace[1389709728] 'read index received' (duration: 575.826248ms)","trace[1389709728] 'applied index is now lower than readState.Index' (duration: 308.608622ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:20:05.591231Z","caller":"traceutil/trace.go:171","msg":"trace[1704595457] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"892.06605ms","start":"2026-05-05T10:20:04.699157Z","end":"2026-05-05T10:20:05.591223Z","steps":["trace[1704595457] 'process raft request' (duration: 583.356625ms)","trace[1704595457] 'compare' (duration: 308.403487ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:20:05.591259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.699134Z","time spent":"892.11189ms","remote":"127.0.0.1:38246","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T10:20:05.591456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.691196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:05.591501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.794868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.591523Z","caller":"traceutil/trace.go:171","msg":"trace[66152434] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"884.847699ms","start":"2026-05-05T10:20:04.706668Z","end":"2026-05-05T10:20:05.591516Z","steps":["trace[66152434] 'agreement among raft nodes before linearized reading' (duration: 884.818739ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:05.59152Z","caller":"traceutil/trace.go:171","msg":"trace[1041395248] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"884.771368ms","start":"2026-05-05T10:20:04.70672Z","end":"2026-05-05T10:20:05.591491Z","steps":["trace[1041395248] 'agreement among raft nodes before linearized reading' (duration: 884.653645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.591568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.960717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.591584Z","caller":"traceutil/trace.go:171","msg":"trace[1185253000] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:587; }","duration":"328.010068ms","start":"2026-05-05T10:20:05.26357Z","end":"2026-05-05T10:20:05.59158Z","steps":["trace[1185253000] 'agreement among raft nodes before linearized reading' (duration: 327.986397ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.591589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.706698Z","time spent":"884.87173ms","remote":"127.0.0.1:49920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.591713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.697604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-05T10:20:05.591751Z","caller":"traceutil/trace.go:171","msg":"trace[1585331417] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"328.907009ms","start":"2026-05-05T10:20:05.262839Z","end":"2026-05-05T10:20:05.591746Z","steps":["trace[1585331417] 'agreement among raft nodes before linearized reading' (duration: 328.773086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.591766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:05.262813Z","time spent":"328.94937ms","remote":"127.0.0.1:38280","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-05T10:20:05.591799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.87243ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.591834Z","caller":"traceutil/trace.go:171","msg":"trace[317798631] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"663.907761ms","start":"2026-05-05T10:20:04.927915Z","end":"2026-05-05T10:20:05.591823Z","steps":["trace[317798631] 'agreement among raft nodes before linearized reading' (duration: 663.850919ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.591877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.927838Z","time spent":"664.030104ms","remote":"127.0.0.1:49958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.591892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.447043ms","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-05T10:20:05.591911Z","caller":"traceutil/trace.go:171","msg":"trace[141777827] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:587; }","duration":"355.498305ms","start":"2026-05-05T10:20:05.236408Z","end":"2026-05-05T10:20:05.591906Z","steps":["trace[141777827] 'agreement among raft nodes before linearized reading' (duration: 355.442723ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.591925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:05.236382Z","time spent":"355.539976ms","remote":"127.0.0.1:38280","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-05T10:20:05.592029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.584716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-05T10:20:05.592022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.097595ms","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-05T10:20:05.592046Z","caller":"traceutil/trace.go:171","msg":"trace[1885036831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:587; }","duration":"355.654549ms","start":"2026-05-05T10:20:05.236387Z","end":"2026-05-05T10:20:05.592041Z","steps":["trace[1885036831] 'agreement among raft nodes before linearized reading' (duration: 355.605178ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:05.592055Z","caller":"traceutil/trace.go:171","msg":"trace[1833161114] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"664.178227ms","start":"2026-05-05T10:20:04.927868Z","end":"2026-05-05T10:20:05.592046Z","steps":["trace[1833161114] 'agreement among raft nodes before linearized reading' (duration: 664.127886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.99947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.592113Z","caller":"traceutil/trace.go:171","msg":"trace[1041720487] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:587; }","duration":"615.045191ms","start":"2026-05-05T10:20:04.977063Z","end":"2026-05-05T10:20:05.592108Z","steps":["trace[1041720487] 'agreement among raft nodes before linearized reading' (duration: 615.011941ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.977052Z","time spent":"615.072332ms","remote":"127.0.0.1:49970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.592131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.18717ms","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-05T10:20:05.592161Z","caller":"traceutil/trace.go:171","msg":"trace[874106611] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"710.22554ms","start":"2026-05-05T10:20:04.881926Z","end":"2026-05-05T10:20:05.592152Z","steps":["trace[874106611] 'agreement among raft nodes before linearized reading' (duration: 710.180759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.881923Z","time spent":"710.257741ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"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-05T10:20:05.592223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"361.700021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-05T10:20:05.592241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.660372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.592252Z","caller":"traceutil/trace.go:171","msg":"trace[1943873026] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:587; }","duration":"361.725492ms","start":"2026-05-05T10:20:05.230516Z","end":"2026-05-05T10:20:05.592242Z","steps":["trace[1943873026] 'agreement among raft nodes before linearized reading' (duration: 361.592678ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:05.592262Z","caller":"traceutil/trace.go:171","msg":"trace[1663088352] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:587; }","duration":"634.703784ms","start":"2026-05-05T10:20:04.957552Z","end":"2026-05-05T10:20:05.592256Z","steps":["trace[1663088352] 'agreement among raft nodes before linearized reading' (duration: 634.669623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:05.230419Z","time spent":"361.851654ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T10:20:05.592282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.95754Z","time spent":"634.737064ms","remote":"127.0.0.1:49960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.592374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"710.456136ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:05.592385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"634.807516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.592405Z","caller":"traceutil/trace.go:171","msg":"trace[998698377] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:587; }","duration":"634.858097ms","start":"2026-05-05T10:20:04.957541Z","end":"2026-05-05T10:20:05.5924Z","steps":["trace[998698377] 'agreement among raft nodes before linearized reading' (duration: 634.823046ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:05.592406Z","caller":"traceutil/trace.go:171","msg":"trace[535247596] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"710.522787ms","start":"2026-05-05T10:20:04.881873Z","end":"2026-05-05T10:20:05.592396Z","steps":["trace[535247596] 'agreement among raft nodes before linearized reading' (duration: 710.460876ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.59242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.957526Z","time spent":"634.889838ms","remote":"127.0.0.1:49960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.592438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.881852Z","time spent":"710.577249ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.592482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.673625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.592504Z","caller":"traceutil/trace.go:171","msg":"trace[1631699346] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:587; }","duration":"592.741367ms","start":"2026-05-05T10:20:04.999753Z","end":"2026-05-05T10:20:05.592495Z","steps":["trace[1631699346] 'agreement among raft nodes before linearized reading' (duration: 592.707096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:05.236361Z","time spent":"355.697369ms","remote":"127.0.0.1:38280","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-05T10:20:05.592528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.999727Z","time spent":"592.791457ms","remote":"127.0.0.1:49974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.592086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.927839Z","time spent":"664.239579ms","remote":"127.0.0.1:49958","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"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-05T10:20:05.592649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.245097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:05.592689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.683933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.592695Z","caller":"traceutil/trace.go:171","msg":"trace[1738862529] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"757.305929ms","start":"2026-05-05T10:20:04.835376Z","end":"2026-05-05T10:20:05.592682Z","steps":["trace[1738862529] 'agreement among raft nodes before linearized reading' (duration: 757.229037ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:05.592716Z","caller":"traceutil/trace.go:171","msg":"trace[1211655544] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:587; }","duration":"614.731584ms","start":"2026-05-05T10:20:04.977975Z","end":"2026-05-05T10:20:05.592707Z","steps":["trace[1211655544] 'agreement among raft nodes before linearized reading' (duration: 614.684192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.835371Z","time spent":"757.35155ms","remote":"127.0.0.1:49946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.592086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"614.859777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.592766Z","caller":"traceutil/trace.go:171","msg":"trace[356400225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:587; }","duration":"615.584004ms","start":"2026-05-05T10:20:04.977173Z","end":"2026-05-05T10:20:05.592757Z","steps":["trace[356400225] 'agreement among raft nodes before linearized reading' (duration: 614.873107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.977124Z","time spent":"615.652825ms","remote":"127.0.0.1:49970","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.592908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.838491ms","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-05T10:20:05.592938Z","caller":"traceutil/trace.go:171","msg":"trace[537608198] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"757.869752ms","start":"2026-05-05T10:20:04.835058Z","end":"2026-05-05T10:20:05.592928Z","steps":["trace[537608198] 'agreement among raft nodes before linearized reading' (duration: 757.818281ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592967Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.835041Z","time spent":"757.918042ms","remote":"127.0.0.1:49946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.591471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"662.911077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593019Z","caller":"traceutil/trace.go:171","msg":"trace[1903040034] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:587; }","duration":"664.514826ms","start":"2026-05-05T10:20:04.928492Z","end":"2026-05-05T10:20:05.593007Z","steps":["trace[1903040034] 'agreement among raft nodes before linearized reading' (duration: 662.949129ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.928468Z","time spent":"664.569586ms","remote":"127.0.0.1:49948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.592409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.207904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593081Z","caller":"traceutil/trace.go:171","msg":"trace[1469630165] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:587; }","duration":"592.91145ms","start":"2026-05-05T10:20:05.000159Z","end":"2026-05-05T10:20:05.59307Z","steps":["trace[1469630165] 'agreement among raft nodes before linearized reading' (duration: 592.220814ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.59312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:05.000146Z","time spent":"592.960842ms","remote":"127.0.0.1:49974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.593165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.23791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593189Z","caller":"traceutil/trace.go:171","msg":"trace[1812789906] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"758.273562ms","start":"2026-05-05T10:20:04.834905Z","end":"2026-05-05T10:20:05.593179Z","steps":["trace[1812789906] 'agreement among raft nodes before linearized reading' (duration: 758.232171ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.59321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.834899Z","time spent":"758.303472ms","remote":"127.0.0.1:49946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.592446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.523401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593268Z","caller":"traceutil/trace.go:171","msg":"trace[591804670] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:587; }","duration":"593.396161ms","start":"2026-05-05T10:20:04.999854Z","end":"2026-05-05T10:20:05.59325Z","steps":["trace[591804670] 'agreement among raft nodes before linearized reading' (duration: 592.571262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.462352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593307Z","caller":"traceutil/trace.go:171","msg":"trace[1339269064] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"822.497873ms","start":"2026-05-05T10:20:04.770802Z","end":"2026-05-05T10:20:05.5933Z","steps":["trace[1339269064] 'agreement among raft nodes before linearized reading' (duration: 822.454092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.99981Z","time spent":"593.486843ms","remote":"127.0.0.1:49974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.593323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.99171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:05.593329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.770795Z","time spent":"822.529133ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T10:20:05.593346Z","caller":"traceutil/trace.go:171","msg":"trace[167171142] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"853.02536ms","start":"2026-05-05T10:20:04.740312Z","end":"2026-05-05T10:20:05.593338Z","steps":["trace[167171142] 'agreement among raft nodes before linearized reading' (duration: 852.981299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.740308Z","time spent":"853.057091ms","remote":"127.0.0.1:49924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.593425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.235743ms","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-05T10:20:05.593441Z","caller":"traceutil/trace.go:171","msg":"trace[1701044988] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"793.258715ms","start":"2026-05-05T10:20:04.800178Z","end":"2026-05-05T10:20:05.593436Z","steps":["trace[1701044988] 'agreement among raft nodes before linearized reading' (duration: 793.227904ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.592743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.977963Z","time spent":"614.772984ms","remote":"127.0.0.1:49960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.593456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.800174Z","time spent":"793.278615ms","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:20:05.593495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"853.193435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593517Z","caller":"traceutil/trace.go:171","msg":"trace[877007175] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"853.242085ms","start":"2026-05-05T10:20:04.740267Z","end":"2026-05-05T10:20:05.59351Z","steps":["trace[877007175] 'agreement among raft nodes before linearized reading' (duration: 853.202275ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.740248Z","time spent":"853.281927ms","remote":"127.0.0.1:49924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.593558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"793.4869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:05.591598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:05.263548Z","time spent":"328.047248ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T10:20:05.593602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"821.661613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593623Z","caller":"traceutil/trace.go:171","msg":"trace[702549249] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"821.698014ms","start":"2026-05-05T10:20:04.771916Z","end":"2026-05-05T10:20:05.593614Z","steps":["trace[702549249] 'agreement among raft nodes before linearized reading' (duration: 821.669763ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.182661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:05.593642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.771904Z","time spent":"821.730584ms","remote":"127.0.0.1:49924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"info","ts":"2026-05-05T10:20:05.593653Z","caller":"traceutil/trace.go:171","msg":"trace[910862293] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:587; }","duration":"886.201812ms","start":"2026-05-05T10:20:04.707442Z","end":"2026-05-05T10:20:05.593644Z","steps":["trace[910862293] 'agreement among raft nodes before linearized reading' (duration: 886.161491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.707392Z","time spent":"886.275333ms","remote":"127.0.0.1:49920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 "} {"level":"warn","ts":"2026-05-05T10:20:05.591544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.706655Z","time spent":"884.88192ms","remote":"127.0.0.1:49920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":89,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.593743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"822.79672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.593762Z","caller":"traceutil/trace.go:171","msg":"trace[1684217147] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"822.857731ms","start":"2026-05-05T10:20:04.770898Z","end":"2026-05-05T10:20:05.593756Z","steps":["trace[1684217147] 'agreement among raft nodes before linearized reading' (duration: 822.82278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593778Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.770875Z","time spent":"822.898702ms","remote":"127.0.0.1:49928","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-05-05T10:20:05.593576Z","caller":"traceutil/trace.go:171","msg":"trace[1010171352] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:587; }","duration":"793.517891ms","start":"2026-05-05T10:20:04.800052Z","end":"2026-05-05T10:20:05.59357Z","steps":["trace[1010171352] 'agreement among raft nodes before linearized reading' (duration: 793.48808ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.593929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.800045Z","time spent":"793.869769ms","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"warn","ts":"2026-05-05T10:20:05.590254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"906.640233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:05.595293Z","caller":"traceutil/trace.go:171","msg":"trace[604512885] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:586; }","duration":"911.765993ms","start":"2026-05-05T10:20:04.683474Z","end":"2026-05-05T10:20:05.59524Z","steps":["trace[604512885] 'range keys from in-memory index tree' (duration: 906.334645ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.595364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.68347Z","time spent":"911.861205ms","remote":"127.0.0.1:49912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"info","ts":"2026-05-05T10:20:05.595416Z","caller":"traceutil/trace.go:171","msg":"trace[623299669] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tzwxz; range_end:; response_count:1; response_revision:586; }","duration":"919.328331ms","start":"2026-05-05T10:20:04.670456Z","end":"2026-05-05T10:20:05.589784Z","steps":["trace[623299669] 'range keys from in-memory index tree' (duration: 918.957582ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:05.59555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:04.670436Z","time spent":"925.075827ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-tzwxz\" "} {"level":"info","ts":"2026-05-05T10:20:08.086253Z","caller":"traceutil/trace.go:171","msg":"trace[1422748175] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"124.525759ms","start":"2026-05-05T10:20:07.961703Z","end":"2026-05-05T10:20:08.086229Z","steps":["trace[1422748175] 'process raft request' (duration: 124.339275ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:08.946165Z","caller":"traceutil/trace.go:171","msg":"trace[923964331] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"144.264845ms","start":"2026-05-05T10:20:08.801863Z","end":"2026-05-05T10:20:08.946128Z","steps":["trace[923964331] 'process raft request' (duration: 138.358786ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:08.94637Z","caller":"traceutil/trace.go:171","msg":"trace[1879991389] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"141.182172ms","start":"2026-05-05T10:20:08.805161Z","end":"2026-05-05T10:20:08.946343Z","steps":["trace[1879991389] 'process raft request' (duration: 140.878335ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:10.047948Z","caller":"traceutil/trace.go:171","msg":"trace[1323752412] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"151.606658ms","start":"2026-05-05T10:20:09.896315Z","end":"2026-05-05T10:20:10.047921Z","steps":["trace[1323752412] 'process raft request' (duration: 123.468636ms)","trace[1323752412] 'compare' (duration: 27.825444ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:20:10.874318Z","caller":"traceutil/trace.go:171","msg":"trace[1099430657] linearizableReadLoop","detail":"{readStateIndex:693; appliedIndex:691; }","duration":"115.402295ms","start":"2026-05-05T10:20:10.758817Z","end":"2026-05-05T10:20:10.874219Z","steps":["trace[1099430657] 'read index received' (duration: 59.161682ms)","trace[1099430657] 'applied index is now lower than readState.Index' (duration: 56.239423ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:20:10.874539Z","caller":"traceutil/trace.go:171","msg":"trace[1504071150] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"130.159543ms","start":"2026-05-05T10:20:10.744327Z","end":"2026-05-05T10:20:10.874486Z","steps":["trace[1504071150] 'process raft request' (duration: 129.653541ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:10.874941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.04742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-05-05T10:20:10.875583Z","caller":"traceutil/trace.go:171","msg":"trace[1438404617] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:670; }","duration":"116.586043ms","start":"2026-05-05T10:20:10.758772Z","end":"2026-05-05T10:20:10.875358Z","steps":["trace[1438404617] 'agreement among raft nodes before linearized reading' (duration: 115.705052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:21.67725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.018612ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T10:20:21.677595Z","caller":"traceutil/trace.go:171","msg":"trace[466013184] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:779; }","duration":"414.3672ms","start":"2026-05-05T10:20:21.26321Z","end":"2026-05-05T10:20:21.677577Z","steps":["trace[466013184] 'read index received' (duration: 78.896376ms)","trace[466013184] 'applied index is now lower than readState.Index' (duration: 335.469314ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:20:21.677685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.463282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:20:21.677718Z","caller":"traceutil/trace.go:171","msg":"trace[1363836403] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:753; }","duration":"414.540404ms","start":"2026-05-05T10:20:21.263168Z","end":"2026-05-05T10:20:21.677708Z","steps":["trace[1363836403] 'agreement among raft nodes before linearized reading' (duration: 414.465002ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:21.677763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:21.263148Z","time spent":"414.596786ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T10:20:25.845668Z","caller":"traceutil/trace.go:171","msg":"trace[1346189411] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:825; }","duration":"102.922721ms","start":"2026-05-05T10:20:25.742722Z","end":"2026-05-05T10:20:25.845645Z","steps":["trace[1346189411] 'read index received' (duration: 102.86859ms)","trace[1346189411] 'applied index is now lower than readState.Index' (duration: 52.461µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:20:25.845907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.181898ms","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-05T10:20:25.845969Z","caller":"traceutil/trace.go:171","msg":"trace[1939393283] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:798; }","duration":"103.311581ms","start":"2026-05-05T10:20:25.742643Z","end":"2026-05-05T10:20:25.845954Z","steps":["trace[1939393283] 'agreement among raft nodes before linearized reading' (duration: 103.103686ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:25.846045Z","caller":"traceutil/trace.go:171","msg":"trace[1139492412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"100.034494ms","start":"2026-05-05T10:20:25.745923Z","end":"2026-05-05T10:20:25.845957Z","steps":["trace[1139492412] 'agreement among raft nodes before linearized reading' (duration: 99.8649ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:26.022529Z","caller":"traceutil/trace.go:171","msg":"trace[1256874583] transaction","detail":"{read_only:false; response_revision:800; number_of_response:1; }","duration":"172.436078ms","start":"2026-05-05T10:20:25.850066Z","end":"2026-05-05T10:20:26.022502Z","steps":["trace[1256874583] 'process raft request' (duration: 172.335965ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:26.023024Z","caller":"traceutil/trace.go:171","msg":"trace[1815955037] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"172.653012ms","start":"2026-05-05T10:20:25.850304Z","end":"2026-05-05T10:20:26.022957Z","steps":["trace[1815955037] 'process raft request' (duration: 172.155761ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:26.023151Z","caller":"traceutil/trace.go:171","msg":"trace[1034238538] transaction","detail":"{read_only:false; response_revision:802; number_of_response:1; }","duration":"172.709894ms","start":"2026-05-05T10:20:25.850429Z","end":"2026-05-05T10:20:26.023139Z","steps":["trace[1034238538] 'process raft request' (duration: 172.374976ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:26.023371Z","caller":"traceutil/trace.go:171","msg":"trace[271282855] linearizableReadLoop","detail":"{readStateIndex:831; appliedIndex:826; }","duration":"164.833419ms","start":"2026-05-05T10:20:25.858519Z","end":"2026-05-05T10:20:26.023353Z","steps":["trace[271282855] 'read index received' (duration: 71.785559ms)","trace[271282855] 'applied index is now lower than readState.Index' (duration: 93.04676ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:20:26.023514Z","caller":"traceutil/trace.go:171","msg":"trace[1052975764] transaction","detail":"{read_only:false; response_revision:803; number_of_response:1; }","duration":"172.516469ms","start":"2026-05-05T10:20:25.850951Z","end":"2026-05-05T10:20:26.023468Z","steps":["trace[1052975764] 'process raft request' (duration: 172.140131ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:26.023583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.043273ms","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-05T10:20:26.023624Z","caller":"traceutil/trace.go:171","msg":"trace[1248961248] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:803; }","duration":"165.155376ms","start":"2026-05-05T10:20:25.858456Z","end":"2026-05-05T10:20:26.023612Z","steps":["trace[1248961248] 'agreement among raft nodes before linearized reading' (duration: 164.945851ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:26.023526Z","caller":"traceutil/trace.go:171","msg":"trace[892195811] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"175.475689ms","start":"2026-05-05T10:20:25.847024Z","end":"2026-05-05T10:20:26.0225Z","steps":["trace[892195811] 'process raft request' (duration: 83.181947ms)","trace[892195811] 'compare' (duration: 92.051846ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:20:26.288558Z","caller":"traceutil/trace.go:171","msg":"trace[435744768] linearizableReadLoop","detail":"{readStateIndex:832; appliedIndex:831; }","duration":"257.939909ms","start":"2026-05-05T10:20:26.030588Z","end":"2026-05-05T10:20:26.288528Z","steps":["trace[435744768] 'read index received' (duration: 257.697904ms)","trace[435744768] 'applied index is now lower than readState.Index' (duration: 240.605µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:20:26.288605Z","caller":"traceutil/trace.go:171","msg":"trace[1300648139] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"258.478812ms","start":"2026-05-05T10:20:26.030099Z","end":"2026-05-05T10:20:26.288578Z","steps":["trace[1300648139] 'process raft request' (duration: 258.251456ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:26.288761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.146204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T10:20:26.288797Z","caller":"traceutil/trace.go:171","msg":"trace[572579818] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:804; }","duration":"258.248246ms","start":"2026-05-05T10:20:26.030538Z","end":"2026-05-05T10:20:26.288786Z","steps":["trace[572579818] 'agreement among raft nodes before linearized reading' (duration: 258.094403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:35.361379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.706151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-ptxnc\" ","response":"range_response_count:1 size:5677"} {"level":"info","ts":"2026-05-05T10:20:35.361478Z","caller":"traceutil/trace.go:171","msg":"trace[99978376] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-78446f96c9-ptxnc; range_end:; response_count:1; response_revision:885; }","duration":"143.854874ms","start":"2026-05-05T10:20:35.217601Z","end":"2026-05-05T10:20:35.361456Z","steps":["trace[99978376] 'range keys from in-memory index tree' (duration: 143.513717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:50.400833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.67097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:50.400941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.87386ms","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-05T10:20:50.400976Z","caller":"traceutil/trace.go:171","msg":"trace[1063936275] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:940; }","duration":"137.832924ms","start":"2026-05-05T10:20:50.26312Z","end":"2026-05-05T10:20:50.400953Z","steps":["trace[1063936275] 'range keys from in-memory index tree' (duration: 137.593447ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:50.400994Z","caller":"traceutil/trace.go:171","msg":"trace[660955337] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:940; }","duration":"167.947592ms","start":"2026-05-05T10:20:50.233031Z","end":"2026-05-05T10:20:50.400979Z","steps":["trace[660955337] 'range keys from in-memory index tree' (duration: 167.722156ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:50.40103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.953282ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-05T10:20:50.401081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.643771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-05-05T10:20:50.401192Z","caller":"traceutil/trace.go:171","msg":"trace[535806531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:940; }","duration":"163.794254ms","start":"2026-05-05T10:20:50.237364Z","end":"2026-05-05T10:20:50.401159Z","steps":["trace[535806531] 'range keys from in-memory index tree' (duration: 163.438146ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:50.40112Z","caller":"traceutil/trace.go:171","msg":"trace[1984979686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:940; }","duration":"168.095415ms","start":"2026-05-05T10:20:50.233003Z","end":"2026-05-05T10:20:50.401099Z","steps":["trace[1984979686] 'range keys from in-memory index tree' (duration: 167.791138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:50.986199Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762521516,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T10:20:51.288449Z","caller":"traceutil/trace.go:171","msg":"trace[1121025335] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"883.448737ms","start":"2026-05-05T10:20:50.404975Z","end":"2026-05-05T10:20:51.288424Z","steps":["trace[1121025335] 'process raft request' (duration: 883.309244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:51.288656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:50.404955Z","time spent":"883.561279ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:20:51.413699Z","caller":"traceutil/trace.go:171","msg":"trace[1853328631] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"1.008218073s","start":"2026-05-05T10:20:50.405449Z","end":"2026-05-05T10:20:51.413667Z","steps":["trace[1853328631] 'process raft request' (duration: 942.756163ms)","trace[1853328631] 'compare' (duration: 65.285776ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:20:51.413876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:50.405436Z","time spent":"1.008350626s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:20:51.414034Z","caller":"traceutil/trace.go:171","msg":"trace[566621376] transaction","detail":"{read_only:false; response_revision:943; number_of_response:1; }","duration":"1.00855809s","start":"2026-05-05T10:20:50.405456Z","end":"2026-05-05T10:20:51.414014Z","steps":["trace[566621376] 'process raft request' (duration: 1.008168411s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:51.414144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:50.405444Z","time spent":"1.008641093s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:20:51.414213Z","caller":"traceutil/trace.go:171","msg":"trace[541562476] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"273.563457ms","start":"2026-05-05T10:20:51.140599Z","end":"2026-05-05T10:20:51.414163Z","steps":["trace[541562476] 'process raft request' (duration: 273.246199ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:51.414472Z","caller":"traceutil/trace.go:171","msg":"trace[2007792577] transaction","detail":"{read_only:false; response_revision:944; number_of_response:1; }","duration":"394.807069ms","start":"2026-05-05T10:20:51.01963Z","end":"2026-05-05T10:20:51.414437Z","steps":["trace[2007792577] 'process raft request' (duration: 394.171774ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:51.414616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:51.01959Z","time spent":"394.950302ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:20:51.429914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.436652ms","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-05T10:20:51.429964Z","caller":"traceutil/trace.go:171","msg":"trace[986449296] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:945; }","duration":"944.520034ms","start":"2026-05-05T10:20:50.485434Z","end":"2026-05-05T10:20:51.429954Z","steps":["trace[986449296] 'agreement among raft nodes before linearized reading' (duration: 944.373491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:51.429995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:50.48542Z","time spent":"944.568665ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T10:20:51.429722Z","caller":"traceutil/trace.go:171","msg":"trace[1438268400] linearizableReadLoop","detail":"{readStateIndex:976; appliedIndex:973; }","duration":"944.230848ms","start":"2026-05-05T10:20:50.485474Z","end":"2026-05-05T10:20:51.429705Z","steps":["trace[1438268400] 'read index received' (duration: 802.82734ms)","trace[1438268400] 'applied index is now lower than readState.Index' (duration: 141.402398ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:20:51.430448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.298197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T10:20:51.430457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.659746ms","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-05T10:20:51.430484Z","caller":"traceutil/trace.go:171","msg":"trace[143716773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:945; }","duration":"167.369658ms","start":"2026-05-05T10:20:51.263103Z","end":"2026-05-05T10:20:51.430472Z","steps":["trace[143716773] 'agreement among raft nodes before linearized reading' (duration: 167.291956ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:20:51.430507Z","caller":"traceutil/trace.go:171","msg":"trace[563865718] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:945; }","duration":"697.764178ms","start":"2026-05-05T10:20:50.73273Z","end":"2026-05-05T10:20:51.430494Z","steps":["trace[563865718] 'agreement among raft nodes before linearized reading' (duration: 697.667666ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:20:51.430549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:20:50.732696Z","time spent":"697.846ms","remote":"127.0.0.1:38242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":28,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"info","ts":"2026-05-05T10:20:57.607378Z","caller":"traceutil/trace.go:171","msg":"trace[559720947] transaction","detail":"{read_only:false; response_revision:966; number_of_response:1; }","duration":"136.080522ms","start":"2026-05-05T10:20:57.47127Z","end":"2026-05-05T10:20:57.60735Z","steps":["trace[559720947] 'process raft request' (duration: 135.11338ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:03.569863Z","caller":"traceutil/trace.go:171","msg":"trace[1036405917] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"160.268967ms","start":"2026-05-05T10:21:03.40957Z","end":"2026-05-05T10:21:03.569839Z","steps":["trace[1036405917] 'process raft request' (duration: 160.086973ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:04.634032Z","caller":"traceutil/trace.go:171","msg":"trace[1760673232] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"335.312178ms","start":"2026-05-05T10:21:04.298696Z","end":"2026-05-05T10:21:04.634009Z","steps":["trace[1760673232] 'process raft request' (duration: 335.147315ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:04.634206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:04.298679Z","time spent":"335.428242ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:21:17.797328Z","caller":"traceutil/trace.go:171","msg":"trace[1790494481] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"153.92646ms","start":"2026-05-05T10:21:17.64338Z","end":"2026-05-05T10:21:17.797307Z","steps":["trace[1790494481] 'process raft request' (duration: 153.795067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:21.283589Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762521792,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T10:21:22.135276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.909131ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T10:21:22.135708Z","caller":"traceutil/trace.go:171","msg":"trace[121321095] linearizableReadLoop","detail":"{readStateIndex:1083; appliedIndex:1082; }","duration":"1.352178967s","start":"2026-05-05T10:21:20.783512Z","end":"2026-05-05T10:21:22.135691Z","steps":["trace[121321095] 'read index received' (duration: 509.785085ms)","trace[121321095] 'applied index is now lower than readState.Index' (duration: 842.392692ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:22.135901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.352394273s","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-05T10:21:22.135931Z","caller":"traceutil/trace.go:171","msg":"trace[1898970790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1042; }","duration":"1.352494295s","start":"2026-05-05T10:21:20.783427Z","end":"2026-05-05T10:21:22.135921Z","steps":["trace[1898970790] 'agreement among raft nodes before linearized reading' (duration: 1.352375282s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:22.135965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:20.783379Z","time spent":"1.352578017s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T10:21:22.1361Z","caller":"traceutil/trace.go:171","msg":"trace[1854203225] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"304.988753ms","start":"2026-05-05T10:21:21.831079Z","end":"2026-05-05T10:21:22.136068Z","steps":["trace[1854203225] 'process raft request' (duration: 304.492102ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:22.136272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:21.831051Z","time spent":"305.129736ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:22.398964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"543.001048ms","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-05T10:21:22.398986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.025667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:21:22.399059Z","caller":"traceutil/trace.go:171","msg":"trace[925781064] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1043; }","duration":"543.13803ms","start":"2026-05-05T10:21:21.855895Z","end":"2026-05-05T10:21:22.399034Z","steps":["trace[925781064] 'agreement among raft nodes before linearized reading' (duration: 280.162755ms)","trace[925781064] 'range keys from in-memory index tree' (duration: 262.764911ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:22.399051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.992254ms","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-05T10:21:22.399071Z","caller":"traceutil/trace.go:171","msg":"trace[1984125862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1043; }","duration":"294.199172ms","start":"2026-05-05T10:21:22.10485Z","end":"2026-05-05T10:21:22.399049Z","steps":["trace[1984125862] 'agreement among raft nodes before linearized reading' (duration: 31.161105ms)","trace[1984125862] 'range keys from in-memory index tree' (duration: 262.900054ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:22.399104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:21.855878Z","time spent":"543.216503ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T10:21:22.399133Z","caller":"traceutil/trace.go:171","msg":"trace[1904576620] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1043; }","duration":"502.124537ms","start":"2026-05-05T10:21:21.896988Z","end":"2026-05-05T10:21:22.399112Z","steps":["trace[1904576620] 'agreement among raft nodes before linearized reading' (duration: 239.06367ms)","trace[1904576620] 'range keys from in-memory index tree' (duration: 262.893173ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:22.399001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"586.358777ms","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-05T10:21:22.399251Z","caller":"traceutil/trace.go:171","msg":"trace[1557233306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1043; }","duration":"586.628683ms","start":"2026-05-05T10:21:21.812599Z","end":"2026-05-05T10:21:22.399228Z","steps":["trace[1557233306] 'agreement among raft nodes before linearized reading' (duration: 323.422662ms)","trace[1557233306] 'range keys from in-memory index tree' (duration: 262.809092ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:22.399284Z","caller":"traceutil/trace.go:171","msg":"trace[305842095] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"258.609384ms","start":"2026-05-05T10:21:22.140658Z","end":"2026-05-05T10:21:22.399268Z","steps":["trace[305842095] 'process raft request' (duration: 171.068068ms)","trace[305842095] 'compare' (duration: 87.420763ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:22.399187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:21.896952Z","time spent":"502.22528ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T10:21:22.39905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.507472ms","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-05T10:21:22.39944Z","caller":"traceutil/trace.go:171","msg":"trace[1949343148] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1043; }","duration":"473.949022ms","start":"2026-05-05T10:21:21.925476Z","end":"2026-05-05T10:21:22.399425Z","steps":["trace[1949343148] 'agreement among raft nodes before linearized reading' (duration: 210.567408ms)","trace[1949343148] 'range keys from in-memory index tree' (duration: 262.840302ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:22.399492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:21.925462Z","time spent":"474.021094ms","remote":"127.0.0.1:38280","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-05T10:21:22.399376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:21.812543Z","time spent":"586.770446ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T10:21:22.406898Z","caller":"traceutil/trace.go:171","msg":"trace[984253453] linearizableReadLoop","detail":"{readStateIndex:1086; appliedIndex:1084; }","duration":"142.770491ms","start":"2026-05-05T10:21:22.264109Z","end":"2026-05-05T10:21:22.406879Z","steps":["trace[984253453] 'read index received' (duration: 47.592357ms)","trace[984253453] 'applied index is now lower than readState.Index' (duration: 95.177254ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:22.407073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.893433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:21:22.407116Z","caller":"traceutil/trace.go:171","msg":"trace[685452108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1045; }","duration":"143.038907ms","start":"2026-05-05T10:21:22.264066Z","end":"2026-05-05T10:21:22.407105Z","steps":["trace[685452108] 'agreement among raft nodes before linearized reading' (duration: 142.890183ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:22.407142Z","caller":"traceutil/trace.go:171","msg":"trace[752146370] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"264.670075ms","start":"2026-05-05T10:21:22.142446Z","end":"2026-05-05T10:21:22.407117Z","steps":["trace[752146370] 'process raft request' (duration: 264.334547ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:22.521145Z","caller":"traceutil/trace.go:171","msg":"trace[1496237020] transaction","detail":"{read_only:false; response_revision:1049; number_of_response:1; }","duration":"115.476466ms","start":"2026-05-05T10:21:22.405646Z","end":"2026-05-05T10:21:22.521122Z","steps":["trace[1496237020] 'process raft request' (duration: 115.363783ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:22.521588Z","caller":"traceutil/trace.go:171","msg":"trace[1533501045] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"117.051972ms","start":"2026-05-05T10:21:22.404522Z","end":"2026-05-05T10:21:22.521574Z","steps":["trace[1533501045] 'process raft request' (duration: 96.038273ms)","trace[1533501045] 'compare' (duration: 20.20548ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:22.521812Z","caller":"traceutil/trace.go:171","msg":"trace[246093797] transaction","detail":"{read_only:false; response_revision:1047; number_of_response:1; }","duration":"116.834767ms","start":"2026-05-05T10:21:22.404966Z","end":"2026-05-05T10:21:22.5218Z","steps":["trace[246093797] 'process raft request' (duration: 115.950097ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:22.521947Z","caller":"traceutil/trace.go:171","msg":"trace[650198099] transaction","detail":"{read_only:false; response_revision:1048; number_of_response:1; }","duration":"116.375217ms","start":"2026-05-05T10:21:22.405563Z","end":"2026-05-05T10:21:22.521938Z","steps":["trace[650198099] 'process raft request' (duration: 115.404384ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:24.696944Z","caller":"traceutil/trace.go:171","msg":"trace[1127719546] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"164.387403ms","start":"2026-05-05T10:21:24.532523Z","end":"2026-05-05T10:21:24.696911Z","steps":["trace[1127719546] 'process raft request' (duration: 130.513135ms)","trace[1127719546] 'compare' (duration: 33.681664ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:24.697111Z","caller":"traceutil/trace.go:171","msg":"trace[815756723] transaction","detail":"{read_only:false; response_revision:1054; number_of_response:1; }","duration":"164.530537ms","start":"2026-05-05T10:21:24.532571Z","end":"2026-05-05T10:21:24.697101Z","steps":["trace[815756723] 'process raft request' (duration: 164.294901ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:24.697068Z","caller":"traceutil/trace.go:171","msg":"trace[945620277] transaction","detail":"{read_only:false; response_revision:1055; number_of_response:1; }","duration":"164.074365ms","start":"2026-05-05T10:21:24.532978Z","end":"2026-05-05T10:21:24.697052Z","steps":["trace[945620277] 'process raft request' (duration: 164.013594ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:30.933163Z","caller":"traceutil/trace.go:171","msg":"trace[396198679] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"139.522485ms","start":"2026-05-05T10:21:30.793623Z","end":"2026-05-05T10:21:30.933145Z","steps":["trace[396198679] 'process raft request' (duration: 100.17837ms)","trace[396198679] 'compare' (duration: 39.210622ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:30.933399Z","caller":"traceutil/trace.go:171","msg":"trace[1486462487] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"139.073195ms","start":"2026-05-05T10:21:30.79429Z","end":"2026-05-05T10:21:30.933363Z","steps":["trace[1486462487] 'process raft request' (duration: 138.830709ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:38.729756Z","caller":"traceutil/trace.go:171","msg":"trace[1603920425] linearizableReadLoop","detail":"{readStateIndex:1195; appliedIndex:1194; }","duration":"116.660353ms","start":"2026-05-05T10:21:38.61307Z","end":"2026-05-05T10:21:38.729731Z","steps":["trace[1603920425] 'read index received' (duration: 116.469889ms)","trace[1603920425] 'applied index is now lower than readState.Index' (duration: 189.264µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:38.730027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.921989ms","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-05T10:21:38.730082Z","caller":"traceutil/trace.go:171","msg":"trace[1328581890] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1149; }","duration":"117.024182ms","start":"2026-05-05T10:21:38.613041Z","end":"2026-05-05T10:21:38.730065Z","steps":["trace[1328581890] 'agreement among raft nodes before linearized reading' (duration: 116.825317ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:38.730591Z","caller":"traceutil/trace.go:171","msg":"trace[959663005] transaction","detail":"{read_only:false; response_revision:1149; number_of_response:1; }","duration":"224.941282ms","start":"2026-05-05T10:21:38.505592Z","end":"2026-05-05T10:21:38.730533Z","steps":["trace[959663005] 'process raft request' (duration: 224.00626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:39.403053Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762522028,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T10:21:39.903635Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762522028,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-05T10:21:40.03736Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.302843302s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-05T10:21:40.122357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.820568ms","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-05T10:21:40.12241Z","caller":"traceutil/trace.go:171","msg":"trace[673297153] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1149; }","duration":"319.92071ms","start":"2026-05-05T10:21:39.802478Z","end":"2026-05-05T10:21:40.122399Z","steps":["trace[673297153] 'range keys from in-memory index tree' (duration: 319.807908ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:40.122654Z","caller":"traceutil/trace.go:171","msg":"trace[187036963] linearizableReadLoop","detail":"{readStateIndex:1196; appliedIndex:1195; }","duration":"1.220329032s","start":"2026-05-05T10:21:38.902298Z","end":"2026-05-05T10:21:40.122627Z","steps":["trace[187036963] 'read index received' (duration: 1.135181072s)","trace[187036963] 'applied index is now lower than readState.Index' (duration: 85.14667ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:40.122663Z","caller":"traceutil/trace.go:171","msg":"trace[1647087259] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"1.388172336s","start":"2026-05-05T10:21:38.734458Z","end":"2026-05-05T10:21:40.12263Z","steps":["trace[1647087259] 'process raft request' (duration: 1.303119598s)","trace[1647087259] 'compare' (duration: 84.70626ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:40.122814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:38.734444Z","time spent":"1.388285928s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:40.122883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.220578987s","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-05T10:21:40.122919Z","caller":"traceutil/trace.go:171","msg":"trace[1117460720] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1150; }","duration":"1.220664659s","start":"2026-05-05T10:21:38.902242Z","end":"2026-05-05T10:21:40.122907Z","steps":["trace[1117460720] 'agreement among raft nodes before linearized reading' (duration: 1.220520786s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:40.122944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:38.902214Z","time spent":"1.220725091s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T10:21:40.123137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.183841893s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-05T10:21:40.123174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.772609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:21:40.123193Z","caller":"traceutil/trace.go:171","msg":"trace[1875246822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1150; }","duration":"860.821301ms","start":"2026-05-05T10:21:39.262366Z","end":"2026-05-05T10:21:40.123187Z","steps":["trace[1875246822] 'agreement among raft nodes before linearized reading' (duration: 860.78851ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:40.123184Z","caller":"traceutil/trace.go:171","msg":"trace[582654590] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1150; }","duration":"1.183941615s","start":"2026-05-05T10:21:38.939231Z","end":"2026-05-05T10:21:40.123173Z","steps":["trace[582654590] 'agreement among raft nodes before linearized reading' (duration: 1.183838143s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:40.123209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:39.262349Z","time spent":"860.856301ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T10:21:40.123228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:38.939208Z","time spent":"1.184012167s","remote":"127.0.0.1:38114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:21:40.123261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.13857261s","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-05T10:21:40.123292Z","caller":"traceutil/trace.go:171","msg":"trace[220237768] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1150; }","duration":"1.138641992s","start":"2026-05-05T10:21:38.98464Z","end":"2026-05-05T10:21:40.123282Z","steps":["trace[220237768] 'agreement among raft nodes before linearized reading' (duration: 1.138524799s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:40.123315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:38.98462Z","time spent":"1.138689233s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T10:21:40.123566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.138035687s","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-05T10:21:40.123597Z","caller":"traceutil/trace.go:171","msg":"trace[164300189] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1150; }","duration":"1.138085159s","start":"2026-05-05T10:21:38.985502Z","end":"2026-05-05T10:21:40.123587Z","steps":["trace[164300189] 'agreement among raft nodes before linearized reading' (duration: 1.137981297s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:40.123619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:38.985491Z","time spent":"1.13812212s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T10:21:52.315321Z","caller":"traceutil/trace.go:171","msg":"trace[185028792] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"137.262093ms","start":"2026-05-05T10:21:52.178035Z","end":"2026-05-05T10:21:52.315297Z","steps":["trace[185028792] 'process raft request' (duration: 136.939895ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:52.605538Z","caller":"traceutil/trace.go:171","msg":"trace[1764312832] transaction","detail":"{read_only:false; response_revision:1193; number_of_response:1; }","duration":"207.559166ms","start":"2026-05-05T10:21:52.397938Z","end":"2026-05-05T10:21:52.605497Z","steps":["trace[1764312832] 'process raft request' (duration: 206.258566ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:53.764029Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762522142,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T10:21:53.820389Z","caller":"traceutil/trace.go:171","msg":"trace[2085896554] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"584.083594ms","start":"2026-05-05T10:21:53.236286Z","end":"2026-05-05T10:21:53.82037Z","steps":["trace[2085896554] 'process raft request' (duration: 583.956061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:53.820529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:53.23626Z","time spent":"584.206688ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:53.820637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.571348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:21:53.82074Z","caller":"traceutil/trace.go:171","msg":"trace[401658027] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1195; }","duration":"557.747492ms","start":"2026-05-05T10:21:53.262981Z","end":"2026-05-05T10:21:53.820729Z","steps":["trace[401658027] 'agreement among raft nodes before linearized reading' (duration: 557.545167ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:53.820773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:53.26296Z","time spent":"557.806574ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T10:21:53.821202Z","caller":"traceutil/trace.go:171","msg":"trace[1015181297] linearizableReadLoop","detail":"{readStateIndex:1244; appliedIndex:1243; }","duration":"557.351363ms","start":"2026-05-05T10:21:53.263027Z","end":"2026-05-05T10:21:53.820378Z","steps":["trace[1015181297] 'read index received' (duration: 557.135217ms)","trace[1015181297] 'applied index is now lower than readState.Index' (duration: 214.035µs)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:55.996285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.462815ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-05-05T10:21:55.996414Z","caller":"traceutil/trace.go:171","msg":"trace[621966765] linearizableReadLoop","detail":"{readStateIndex:1266; appliedIndex:1265; }","duration":"222.199918ms","start":"2026-05-05T10:21:55.774192Z","end":"2026-05-05T10:21:55.996392Z","steps":["trace[621966765] 'read index received' (duration: 91.519119ms)","trace[621966765] 'applied index is now lower than readState.Index' (duration: 130.675659ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:55.996525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.327571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-05T10:21:55.996564Z","caller":"traceutil/trace.go:171","msg":"trace[709243067] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:1216; }","duration":"222.396183ms","start":"2026-05-05T10:21:55.774156Z","end":"2026-05-05T10:21:55.996552Z","steps":["trace[709243067] 'agreement among raft nodes before linearized reading' (duration: 222.291351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:56.825648Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762522188,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T10:21:56.999765Z","caller":"traceutil/trace.go:171","msg":"trace[1106611252] transaction","detail":"{read_only:false; response_revision:1219; number_of_response:1; }","duration":"902.197373ms","start":"2026-05-05T10:21:56.097545Z","end":"2026-05-05T10:21:56.999743Z","steps":["trace[1106611252] 'process raft request' (duration: 902.050569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:56.999911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:56.097524Z","time spent":"902.307676ms","remote":"127.0.0.1:38206","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:57.321999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.838703ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T10:21:57.322093Z","caller":"traceutil/trace.go:171","msg":"trace[1392666601] linearizableReadLoop","detail":"{readStateIndex:1270; appliedIndex:1268; }","duration":"997.071079ms","start":"2026-05-05T10:21:56.325003Z","end":"2026-05-05T10:21:57.322074Z","steps":["trace[1392666601] 'read index received' (duration: 673.676178ms)","trace[1392666601] 'applied index is now lower than readState.Index' (duration: 323.393881ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:57.322155Z","caller":"traceutil/trace.go:171","msg":"trace[650842898] transaction","detail":"{read_only:false; response_revision:1220; number_of_response:1; }","duration":"692.695011ms","start":"2026-05-05T10:21:56.62945Z","end":"2026-05-05T10:21:57.322145Z","steps":["trace[650842898] 'process raft request' (duration: 469.643323ms)","trace[650842898] 'compare' (duration: 222.661189ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:21:57.322213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:56.629423Z","time spent":"692.760872ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:57.322462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"997.437469ms","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-05T10:21:57.322609Z","caller":"traceutil/trace.go:171","msg":"trace[25860453] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1220; }","duration":"997.580391ms","start":"2026-05-05T10:21:56.324956Z","end":"2026-05-05T10:21:57.322537Z","steps":["trace[25860453] 'agreement among raft nodes before linearized reading' (duration: 997.216363ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:57.322727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:56.324936Z","time spent":"997.774736ms","remote":"127.0.0.1:38280","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-05T10:21:57.352381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.013464381s","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-05T10:21:57.352467Z","caller":"traceutil/trace.go:171","msg":"trace[530835125] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1223; }","duration":"1.013588994s","start":"2026-05-05T10:21:56.338862Z","end":"2026-05-05T10:21:57.352451Z","steps":["trace[530835125] 'agreement among raft nodes before linearized reading' (duration: 1.013384799s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:57.35251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:56.33884Z","time spent":"1.013661175s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-05T10:21:57.352956Z","caller":"traceutil/trace.go:171","msg":"trace[616009295] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"341.651266ms","start":"2026-05-05T10:21:57.011287Z","end":"2026-05-05T10:21:57.352939Z","steps":["trace[616009295] 'process raft request' (duration: 340.912579ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:57.353212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.000420307s","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-05T10:21:57.353326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.003865078s","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-05T10:21:57.353259Z","caller":"traceutil/trace.go:171","msg":"trace[1352705887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1223; }","duration":"1.000493809s","start":"2026-05-05T10:21:56.352753Z","end":"2026-05-05T10:21:57.353247Z","steps":["trace[1352705887] 'agreement among raft nodes before linearized reading' (duration: 1.000374297s)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:57.353405Z","caller":"traceutil/trace.go:171","msg":"trace[2123855832] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1223; }","duration":"1.00396725s","start":"2026-05-05T10:21:56.349419Z","end":"2026-05-05T10:21:57.353386Z","steps":["trace[2123855832] 'agreement among raft nodes before linearized reading' (duration: 1.003765225s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:57.35345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:56.349409Z","time spent":"1.004032931s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T10:21:57.353754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:56.352732Z","time spent":"1.001001791s","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-05T10:21:57.353954Z","caller":"traceutil/trace.go:171","msg":"trace[115425781] transaction","detail":"{read_only:false; response_revision:1221; number_of_response:1; }","duration":"349.650292ms","start":"2026-05-05T10:21:57.004292Z","end":"2026-05-05T10:21:57.353942Z","steps":["trace[115425781] 'process raft request' (duration: 347.731737ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:57.354042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:57.004277Z","time spent":"349.708274ms","remote":"127.0.0.1:38186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":915,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:57.354207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:57.011266Z","time spent":"341.739408ms","remote":"127.0.0.1:38526","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9375,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:21:57.354493Z","caller":"traceutil/trace.go:171","msg":"trace[514323346] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"346.952249ms","start":"2026-05-05T10:21:57.00753Z","end":"2026-05-05T10:21:57.354482Z","steps":["trace[514323346] 'process raft request' (duration: 344.619175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:57.354598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:57.007523Z","time spent":"347.00783ms","remote":"127.0.0.1:38290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:57.354965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.837786ms","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-05T10:21:57.355017Z","caller":"traceutil/trace.go:171","msg":"trace[1434361650] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1223; }","duration":"527.925228ms","start":"2026-05-05T10:21:56.82708Z","end":"2026-05-05T10:21:57.355005Z","steps":["trace[1434361650] 'agreement among raft nodes before linearized reading' (duration: 527.416366ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:57.35514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:56.82706Z","time spent":"528.069352ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T10:21:57.514873Z","caller":"traceutil/trace.go:171","msg":"trace[791844126] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"148.048173ms","start":"2026-05-05T10:21:57.366804Z","end":"2026-05-05T10:21:57.514852Z","steps":["trace[791844126] 'process raft request' (duration: 148.014802ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:57.515143Z","caller":"traceutil/trace.go:171","msg":"trace[979467354] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"152.314642ms","start":"2026-05-05T10:21:57.362809Z","end":"2026-05-05T10:21:57.515123Z","steps":["trace[979467354] 'process raft request' (duration: 151.976544ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:57.515241Z","caller":"traceutil/trace.go:171","msg":"trace[423075636] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"152.422995ms","start":"2026-05-05T10:21:57.362809Z","end":"2026-05-05T10:21:57.515232Z","steps":["trace[423075636] 'process raft request' (duration: 151.861852ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:58.78688Z","caller":"traceutil/trace.go:171","msg":"trace[2136761804] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"334.50136ms","start":"2026-05-05T10:21:58.452354Z","end":"2026-05-05T10:21:58.786855Z","steps":["trace[2136761804] 'process raft request' (duration: 334.347106ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:58.787023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:58.452331Z","time spent":"334.618483ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:21:59.822583Z","caller":"traceutil/trace.go:171","msg":"trace[1714124651] linearizableReadLoop","detail":"{readStateIndex:1282; appliedIndex:1281; }","duration":"397.852642ms","start":"2026-05-05T10:21:59.424684Z","end":"2026-05-05T10:21:59.822537Z","steps":["trace[1714124651] 'read index received' (duration: 397.712239ms)","trace[1714124651] 'applied index is now lower than readState.Index' (duration: 139.563µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:21:59.822726Z","caller":"traceutil/trace.go:171","msg":"trace[389941728] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"439.014959ms","start":"2026-05-05T10:21:59.383699Z","end":"2026-05-05T10:21:59.822714Z","steps":["trace[389941728] 'process raft request' (duration: 438.712882ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:59.822833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:59.383682Z","time spent":"439.078621ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:21:59.822859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.167333ms","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-05T10:21:59.822911Z","caller":"traceutil/trace.go:171","msg":"trace[1404669334] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1232; }","duration":"304.257406ms","start":"2026-05-05T10:21:59.518642Z","end":"2026-05-05T10:21:59.8229Z","steps":["trace[1404669334] 'agreement among raft nodes before linearized reading' (duration: 304.116512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:59.822937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:59.518625Z","time spent":"304.306136ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-05T10:21:59.822915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.21135ms","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-05T10:21:59.822941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.307286ms","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-05T10:21:59.822942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.166923ms","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-05T10:21:59.822822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.935078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:21:59.822985Z","caller":"traceutil/trace.go:171","msg":"trace[1033203593] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1232; }","duration":"304.365338ms","start":"2026-05-05T10:21:59.518604Z","end":"2026-05-05T10:21:59.82297Z","steps":["trace[1033203593] 'agreement among raft nodes before linearized reading' (duration: 304.258166ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:59.822984Z","caller":"traceutil/trace.go:171","msg":"trace[1837333168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1232; }","duration":"398.322903ms","start":"2026-05-05T10:21:59.424641Z","end":"2026-05-05T10:21:59.822963Z","steps":["trace[1837333168] 'agreement among raft nodes before linearized reading' (duration: 398.114468ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:59.822996Z","caller":"traceutil/trace.go:171","msg":"trace[1953555470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1232; }","duration":"304.263296ms","start":"2026-05-05T10:21:59.518718Z","end":"2026-05-05T10:21:59.822982Z","steps":["trace[1953555470] 'agreement among raft nodes before linearized reading' (duration: 304.069791ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:21:59.823014Z","caller":"traceutil/trace.go:171","msg":"trace[2043242075] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1232; }","duration":"347.199454ms","start":"2026-05-05T10:21:59.475805Z","end":"2026-05-05T10:21:59.823004Z","steps":["trace[2043242075] 'agreement among raft nodes before linearized reading' (duration: 346.954838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:21:59.82302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:59.51859Z","time spent":"304.422589ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T10:21:59.823035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:59.475791Z","time spent":"347.235755ms","remote":"127.0.0.1:52262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"warn","ts":"2026-05-05T10:21:59.823028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:59.42462Z","time spent":"398.398435ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-05T10:21:59.823033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:21:59.518699Z","time spent":"304.327577ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-05T10:22:00.071325Z","caller":"traceutil/trace.go:171","msg":"trace[108693564] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"243.453292ms","start":"2026-05-05T10:21:59.827851Z","end":"2026-05-05T10:22:00.071304Z","steps":["trace[108693564] 'process raft request' (duration: 243.420001ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:00.071446Z","caller":"traceutil/trace.go:171","msg":"trace[883593467] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"243.830421ms","start":"2026-05-05T10:21:59.827552Z","end":"2026-05-05T10:22:00.071383Z","steps":["trace[883593467] 'process raft request' (duration: 162.746825ms)","trace[883593467] 'compare' (duration: 80.711067ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:22:00.071514Z","caller":"traceutil/trace.go:171","msg":"trace[766776167] transaction","detail":"{read_only:false; response_revision:1234; number_of_response:1; }","duration":"243.777599ms","start":"2026-05-05T10:21:59.827723Z","end":"2026-05-05T10:22:00.071501Z","steps":["trace[766776167] 'process raft request' (duration: 243.469502ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:00.071602Z","caller":"traceutil/trace.go:171","msg":"trace[2079439778] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"243.799341ms","start":"2026-05-05T10:21:59.827796Z","end":"2026-05-05T10:22:00.071595Z","steps":["trace[2079439778] 'process raft request' (duration: 243.443212ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:00.37403Z","caller":"traceutil/trace.go:171","msg":"trace[1130353006] linearizableReadLoop","detail":"{readStateIndex:1287; appliedIndex:1286; }","duration":"111.510223ms","start":"2026-05-05T10:22:00.262499Z","end":"2026-05-05T10:22:00.374009Z","steps":["trace[1130353006] 'read index received' (duration: 111.348359ms)","trace[1130353006] 'applied index is now lower than readState.Index' (duration: 160.994µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:22:00.374131Z","caller":"traceutil/trace.go:171","msg":"trace[1401763041] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"124.315632ms","start":"2026-05-05T10:22:00.249806Z","end":"2026-05-05T10:22:00.374121Z","steps":["trace[1401763041] 'process raft request' (duration: 124.092546ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:00.374514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.999825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:22:00.374548Z","caller":"traceutil/trace.go:171","msg":"trace[1984300561] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1237; }","duration":"112.061076ms","start":"2026-05-05T10:22:00.262477Z","end":"2026-05-05T10:22:00.374538Z","steps":["trace[1984300561] 'agreement among raft nodes before linearized reading' (duration: 112.000185ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:00.600187Z","caller":"traceutil/trace.go:171","msg":"trace[1444891850] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"220.342995ms","start":"2026-05-05T10:22:00.379823Z","end":"2026-05-05T10:22:00.600166Z","steps":["trace[1444891850] 'process raft request' (duration: 178.819459ms)","trace[1444891850] 'compare' (duration: 41.422984ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:22:00.908853Z","caller":"traceutil/trace.go:171","msg":"trace[418166485] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"305.297811ms","start":"2026-05-05T10:22:00.603531Z","end":"2026-05-05T10:22:00.908829Z","steps":["trace[418166485] 'process raft request' (duration: 284.148239ms)","trace[418166485] 'compare' (duration: 20.918516ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:22:00.908992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:00.603509Z","time spent":"305.415903ms","remote":"127.0.0.1:38100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:22:00.909197Z","caller":"traceutil/trace.go:171","msg":"trace[972050697] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"303.434647ms","start":"2026-05-05T10:22:00.605751Z","end":"2026-05-05T10:22:00.909186Z","steps":["trace[972050697] 'process raft request' (duration: 302.974116ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:00.909255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:00.605733Z","time spent":"303.495799ms","remote":"127.0.0.1:38100","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T10:22:00.909616Z","caller":"traceutil/trace.go:171","msg":"trace[1062626245] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"301.594584ms","start":"2026-05-05T10:22:00.60798Z","end":"2026-05-05T10:22:00.909575Z","steps":["trace[1062626245] 'process raft request' (duration: 300.783845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:00.909744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:00.60797Z","time spent":"301.700877ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T10:22:11.05749Z","caller":"traceutil/trace.go:171","msg":"trace[1498118330] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"116.624901ms","start":"2026-05-05T10:22:10.940837Z","end":"2026-05-05T10:22:11.057462Z","steps":["trace[1498118330] 'process raft request' (duration: 116.464847ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:11.765288Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10348319730762522367,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T10:22:11.980496Z","caller":"traceutil/trace.go:171","msg":"trace[778361104] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"537.138026ms","start":"2026-05-05T10:22:11.443324Z","end":"2026-05-05T10:22:11.980462Z","steps":["trace[778361104] 'process raft request' (duration: 536.920971ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:11.980446Z","caller":"traceutil/trace.go:171","msg":"trace[1491620585] linearizableReadLoop","detail":"{readStateIndex:1370; appliedIndex:1368; }","duration":"716.200884ms","start":"2026-05-05T10:22:11.26422Z","end":"2026-05-05T10:22:11.98042Z","steps":["trace[1491620585] 'read index received' (duration: 708.944969ms)","trace[1491620585] 'applied index is now lower than readState.Index' (duration: 7.254665ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T10:22:11.980677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:11.443298Z","time spent":"537.276439ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T10:22:11.980834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"716.573513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T10:22:11.98093Z","caller":"traceutil/trace.go:171","msg":"trace[882792773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1317; }","duration":"716.742096ms","start":"2026-05-05T10:22:11.26417Z","end":"2026-05-05T10:22:11.980912Z","steps":["trace[882792773] 'agreement among raft nodes before linearized reading' (duration: 716.505841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:11.980961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:11.264151Z","time spent":"716.803028ms","remote":"127.0.0.1:38048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-05T10:22:11.980931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.163574ms","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:531"} {"level":"warn","ts":"2026-05-05T10:22:11.981182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.954904ms","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-05T10:22:11.981213Z","caller":"traceutil/trace.go:171","msg":"trace[1997888093] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1317; }","duration":"694.522062ms","start":"2026-05-05T10:22:11.286674Z","end":"2026-05-05T10:22:11.981196Z","steps":["trace[1997888093] 'agreement among raft nodes before linearized reading' (duration: 694.093682ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:11.981244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T10:22:11.286655Z","time spent":"694.581423ms","remote":"127.0.0.1:38280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-05T10:22:11.981231Z","caller":"traceutil/trace.go:171","msg":"trace[1129911724] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1317; }","duration":"112.003685ms","start":"2026-05-05T10:22:11.86921Z","end":"2026-05-05T10:22:11.981214Z","steps":["trace[1129911724] 'agreement among raft nodes before linearized reading' (duration: 111.829931ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:32.449767Z","caller":"traceutil/trace.go:171","msg":"trace[1209565553] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"133.015972ms","start":"2026-05-05T10:22:32.316712Z","end":"2026-05-05T10:22:32.449728Z","steps":["trace[1209565553] 'process raft request' (duration: 111.195886ms)","trace[1209565553] 'compare' (duration: 21.593631ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:22:32.449946Z","caller":"traceutil/trace.go:171","msg":"trace[1381826386] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"132.966782ms","start":"2026-05-05T10:22:32.316956Z","end":"2026-05-05T10:22:32.449923Z","steps":["trace[1381826386] 'process raft request' (duration: 132.668485ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:32.449983Z","caller":"traceutil/trace.go:171","msg":"trace[1931126176] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"132.946641ms","start":"2026-05-05T10:22:32.317029Z","end":"2026-05-05T10:22:32.449975Z","steps":["trace[1931126176] 'process raft request' (duration: 132.641284ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:38.467132Z","caller":"traceutil/trace.go:171","msg":"trace[1343603562] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"112.63098ms","start":"2026-05-05T10:22:38.354476Z","end":"2026-05-05T10:22:38.467107Z","steps":["trace[1343603562] 'process raft request' (duration: 112.475616ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:22:38.468117Z","caller":"traceutil/trace.go:171","msg":"trace[454027276] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"112.678131ms","start":"2026-05-05T10:22:38.355396Z","end":"2026-05-05T10:22:38.468074Z","steps":["trace[454027276] 'process raft request' (duration: 112.452836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:40.350277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.617598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:524"} {"level":"info","ts":"2026-05-05T10:22:40.350355Z","caller":"traceutil/trace.go:171","msg":"trace[71068894] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1447; }","duration":"148.73579ms","start":"2026-05-05T10:22:40.2016Z","end":"2026-05-05T10:22:40.350336Z","steps":["trace[71068894] 'range keys from in-memory index tree' (duration: 148.452193ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:22:45.915966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.638605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-05-05T10:22:45.916035Z","caller":"traceutil/trace.go:171","msg":"trace[359344622] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1474; }","duration":"114.726587ms","start":"2026-05-05T10:22:45.801292Z","end":"2026-05-05T10:22:45.916019Z","steps":["trace[359344622] 'range keys from in-memory index tree' (duration: 114.505041ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:23:23.08317Z","caller":"traceutil/trace.go:171","msg":"trace[1107188170] linearizableReadLoop","detail":"{readStateIndex:1710; appliedIndex:1709; }","duration":"118.814977ms","start":"2026-05-05T10:23:22.964337Z","end":"2026-05-05T10:23:23.083152Z","steps":["trace[1107188170] 'read index received' (duration: 118.704345ms)","trace[1107188170] 'applied index is now lower than readState.Index' (duration: 110.042µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:23:23.083205Z","caller":"traceutil/trace.go:171","msg":"trace[1013440374] transaction","detail":"{read_only:false; response_revision:1643; number_of_response:1; }","duration":"139.922802ms","start":"2026-05-05T10:23:22.943265Z","end":"2026-05-05T10:23:23.083187Z","steps":["trace[1013440374] 'process raft request' (duration: 139.775059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:23:23.083554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.064269ms","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-05T10:23:23.083581Z","caller":"traceutil/trace.go:171","msg":"trace[272914645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1643; }","duration":"109.11973ms","start":"2026-05-05T10:23:22.974453Z","end":"2026-05-05T10:23:23.083573Z","steps":["trace[272914645] 'agreement among raft nodes before linearized reading' (duration: 109.058809ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:23:23.083392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.985361ms","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:531"} {"level":"info","ts":"2026-05-05T10:23:23.08387Z","caller":"traceutil/trace.go:171","msg":"trace[686565976] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1643; }","duration":"119.512073ms","start":"2026-05-05T10:23:22.964317Z","end":"2026-05-05T10:23:23.083829Z","steps":["trace[686565976] 'agreement among raft nodes before linearized reading' (duration: 118.920709ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:23:23.083761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.760927ms","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-05T10:23:23.084131Z","caller":"traceutil/trace.go:171","msg":"trace[229405383] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1643; }","duration":"105.145507ms","start":"2026-05-05T10:23:22.978975Z","end":"2026-05-05T10:23:23.08412Z","steps":["trace[229405383] 'agreement among raft nodes before linearized reading' (duration: 104.700547ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:23:23.193534Z","caller":"traceutil/trace.go:171","msg":"trace[665321301] transaction","detail":"{read_only:false; response_revision:1645; number_of_response:1; }","duration":"106.075309ms","start":"2026-05-05T10:23:23.08743Z","end":"2026-05-05T10:23:23.193505Z","steps":["trace[665321301] 'process raft request' (duration: 92.011819ms)","trace[665321301] 'compare' (duration: 13.908886ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:23:23.193751Z","caller":"traceutil/trace.go:171","msg":"trace[1198314992] transaction","detail":"{read_only:false; response_revision:1646; number_of_response:1; }","duration":"106.050529ms","start":"2026-05-05T10:23:23.087687Z","end":"2026-05-05T10:23:23.193738Z","steps":["trace[1198314992] 'process raft request' (duration: 105.771352ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:23:23.193957Z","caller":"traceutil/trace.go:171","msg":"trace[1533071201] transaction","detail":"{read_only:false; response_revision:1647; number_of_response:1; }","duration":"105.986576ms","start":"2026-05-05T10:23:23.087961Z","end":"2026-05-05T10:23:23.193947Z","steps":["trace[1533071201] 'process raft request' (duration: 105.72725ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T10:25:44.221763Z","caller":"traceutil/trace.go:171","msg":"trace[1194776729] linearizableReadLoop","detail":"{readStateIndex:2419; appliedIndex:2418; }","duration":"106.2259ms","start":"2026-05-05T10:25:44.115515Z","end":"2026-05-05T10:25:44.221741Z","steps":["trace[1194776729] 'read index received' (duration: 106.053276ms)","trace[1194776729] 'applied index is now lower than readState.Index' (duration: 171.724µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T10:25:44.221839Z","caller":"traceutil/trace.go:171","msg":"trace[752984315] transaction","detail":"{read_only:false; response_revision:2323; number_of_response:1; }","duration":"106.418424ms","start":"2026-05-05T10:25:44.115391Z","end":"2026-05-05T10:25:44.221809Z","steps":["trace[752984315] 'process raft request' (duration: 106.23483ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:25:44.221993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.461426ms","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:530"} {"level":"info","ts":"2026-05-05T10:25:44.222032Z","caller":"traceutil/trace.go:171","msg":"trace[1285705271] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2323; }","duration":"106.570658ms","start":"2026-05-05T10:25:44.11545Z","end":"2026-05-05T10:25:44.222021Z","steps":["trace[1285705271] 'agreement among raft nodes before linearized reading' (duration: 106.431105ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T10:25:44.223063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.105963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" limit:500 ","response":"range_response_count:1 size:1893"} {"level":"info","ts":"2026-05-05T10:25:44.223108Z","caller":"traceutil/trace.go:171","msg":"trace[543314854] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:1; response_revision:2323; }","duration":"102.168445ms","start":"2026-05-05T10:25:44.120928Z","end":"2026-05-05T10:25:44.223096Z","steps":["trace[543314854] 'agreement among raft nodes before linearized reading' (duration: 101.365096ms)"],"step_count":1}