{"level":"warn","ts":"2026-08-13T07:50:23.039667Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T07:50:23.03984Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.102: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.102:2380","--initial-cluster=instance=https://199.19.213.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.102: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-08-13T07:50:23.040246Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-13T07:50:23.040266Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.102:2380"]} {"level":"info","ts":"2026-08-13T07:50:23.040298Z","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-08-13T07:50:23.041435Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"]} {"level":"info","ts":"2026-08-13T07:50:23.041567Z","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.102:2380"],"listen-peer-urls":["https://199.19.213.102:2380"],"advertise-client-urls":["https://199.19.213.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.102: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-08-13T07:50:23.047827Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.891218ms"} {"level":"info","ts":"2026-08-13T07:50:23.065745Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1ee87564e61d159f","cluster-id":"92a92aec402e97c3"} {"level":"info","ts":"2026-08-13T07:50:23.179773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=()"} {"level":"info","ts":"2026-08-13T07:50:23.179835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became follower at term 0"} {"level":"info","ts":"2026-08-13T07:50:23.179855Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1ee87564e61d159f [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-13T07:50:23.179864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became follower at term 1"} {"level":"info","ts":"2026-08-13T07:50:23.17995Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=(2227159091952555423)"} {"level":"warn","ts":"2026-08-13T07:50:23.496575Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-13T07:50:23.500601Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-13T07:50:23.502185Z","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-08-13T07:50:23.504851Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1ee87564e61d159f","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-13T07:50:23.506037Z","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-08-13T07:50:23.506175Z","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-08-13T07:50:23.50619Z","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-08-13T07:50:23.506252Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1ee87564e61d159f","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-13T07:50:23.50834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f switched to configuration voters=(2227159091952555423)"} {"level":"info","ts":"2026-08-13T07:50:23.508463Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"92a92aec402e97c3","local-member-id":"1ee87564e61d159f","added-peer-id":"1ee87564e61d159f","added-peer-peer-urls":["https://199.19.213.102:2380"]} {"level":"info","ts":"2026-08-13T07:50:23.513558Z","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-08-13T07:50:23.51396Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1ee87564e61d159f","initial-advertise-peer-urls":["https://199.19.213.102:2380"],"listen-peer-urls":["https://199.19.213.102:2380"],"advertise-client-urls":["https://199.19.213.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-13T07:50:23.514006Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-13T07:50:23.514149Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.102:2380"} {"level":"info","ts":"2026-08-13T07:50:23.514164Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.102:2380"} {"level":"info","ts":"2026-08-13T07:50:23.981164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f is starting a new election at term 1"} {"level":"info","ts":"2026-08-13T07:50:23.981293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became pre-candidate at term 1"} {"level":"info","ts":"2026-08-13T07:50:23.981318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f received MsgPreVoteResp from 1ee87564e61d159f at term 1"} {"level":"info","ts":"2026-08-13T07:50:23.981337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became candidate at term 2"} {"level":"info","ts":"2026-08-13T07:50:23.981345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f received MsgVoteResp from 1ee87564e61d159f at term 2"} {"level":"info","ts":"2026-08-13T07:50:23.981368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1ee87564e61d159f became leader at term 2"} {"level":"info","ts":"2026-08-13T07:50:23.981378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1ee87564e61d159f elected leader 1ee87564e61d159f at term 2"} {"level":"info","ts":"2026-08-13T07:50:23.983116Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:50:23.985347Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1ee87564e61d159f","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.102:2379]}","request-path":"/0/members/1ee87564e61d159f/attributes","cluster-id":"92a92aec402e97c3","publish-timeout":"7s"} {"level":"info","ts":"2026-08-13T07:50:23.985527Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:50:23.985504Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-13T07:50:23.985814Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"92a92aec402e97c3","local-member-id":"1ee87564e61d159f","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:50:23.985894Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:50:23.985923Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-13T07:50:23.985951Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-13T07:50:23.985962Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-13T07:50:23.988046Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-13T07:50:23.994366Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.102:2379"} {"level":"warn","ts":"2026-08-13T07:50:32.881412Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617105080,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T07:50:32.982741Z","caller":"traceutil/trace.go:171","msg":"trace[184053826] transaction","detail":"{read_only:false; number_of_response:0; response_revision:313; }","duration":"682.538363ms","start":"2026-08-13T07:50:32.30005Z","end":"2026-08-13T07:50:32.982588Z","steps":["trace[184053826] 'process raft request' (duration: 682.35959ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:32.984426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:32.300014Z","time spent":"682.914188ms","remote":"127.0.0.1:41726","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-08-13T07:50:33.480068Z","caller":"traceutil/trace.go:171","msg":"trace[698417623] linearizableReadLoop","detail":"{readStateIndex:324; appliedIndex:322; }","duration":"1.099123705s","start":"2026-08-13T07:50:32.380913Z","end":"2026-08-13T07:50:33.480037Z","steps":["trace[698417623] 'read index received' (duration: 601.542586ms)","trace[698417623] 'applied index is now lower than readState.Index' (duration: 497.580089ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:50:33.48024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176697656s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-08-13T07:50:33.480298Z","caller":"traceutil/trace.go:171","msg":"trace[1626386974] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:314; }","duration":"1.176816779s","start":"2026-08-13T07:50:32.303469Z","end":"2026-08-13T07:50:33.480286Z","steps":["trace[1626386974] 'agreement among raft nodes before linearized reading' (duration: 1.176701627s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:33.480339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:32.303456Z","time spent":"1.176877s","remote":"127.0.0.1:41652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-08-13T07:50:33.4803Z","caller":"traceutil/trace.go:171","msg":"trace[616336899] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"1.074592631s","start":"2026-08-13T07:50:32.405634Z","end":"2026-08-13T07:50:33.480227Z","steps":["trace[616336899] 'process raft request' (duration: 1.074241365s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:33.480569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097320655s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"warn","ts":"2026-08-13T07:50:33.480701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"494.682592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4664"} {"level":"info","ts":"2026-08-13T07:50:33.480726Z","caller":"traceutil/trace.go:171","msg":"trace[1907985854] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:314; }","duration":"494.761484ms","start":"2026-08-13T07:50:32.985956Z","end":"2026-08-13T07:50:33.480718Z","steps":["trace[1907985854] 'agreement among raft nodes before linearized reading' (duration: 494.717453ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:33.480751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:32.985927Z","time spent":"494.818815ms","remote":"127.0.0.1:41726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":4687,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"info","ts":"2026-08-13T07:50:33.480746Z","caller":"traceutil/trace.go:171","msg":"trace[172014835] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:314; }","duration":"1.097509689s","start":"2026-08-13T07:50:32.383201Z","end":"2026-08-13T07:50:33.48071Z","steps":["trace[172014835] 'agreement among raft nodes before linearized reading' (duration: 1.097282245s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:33.480794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:32.383179Z","time spent":"1.09760357s","remote":"127.0.0.1:41726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4003,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"warn","ts":"2026-08-13T07:50:33.480923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:32.40561Z","time spent":"1.074821345s","remote":"127.0.0.1:41726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:50:33.48095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.979826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T07:50:33.480992Z","caller":"traceutil/trace.go:171","msg":"trace[656285458] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:314; }","duration":"518.055277ms","start":"2026-08-13T07:50:32.962925Z","end":"2026-08-13T07:50:33.48098Z","steps":["trace[656285458] 'agreement among raft nodes before linearized reading' (duration: 517.973996ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:33.481025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:32.9629Z","time spent":"518.116599ms","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-13T07:50:33.986745Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617105083,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:50:35.838487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.422022295s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:50:35.838767Z","caller":"traceutil/trace.go:171","msg":"trace[685442829] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"2.353220615s","start":"2026-08-13T07:50:33.485498Z","end":"2026-08-13T07:50:35.838719Z","steps":["trace[685442829] 'process raft request' (duration: 930.545399ms)","trace[685442829] 'compare' (duration: 1.421569468s)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:50:35.839502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:33.48548Z","time spent":"2.353801244s","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:50:35.839761Z","caller":"traceutil/trace.go:171","msg":"trace[116101595] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"2.354141809s","start":"2026-08-13T07:50:33.485601Z","end":"2026-08-13T07:50:35.839743Z","steps":["trace[116101595] 'process raft request' (duration: 2.353021121s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:35.839898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:33.485576Z","time spent":"2.354256811s","remote":"127.0.0.1:41738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":190,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-13T07:50:35.840044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.353969376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-08-13T07:50:35.84013Z","caller":"traceutil/trace.go:171","msg":"trace[1493600785] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:316; }","duration":"2.354079768s","start":"2026-08-13T07:50:33.486023Z","end":"2026-08-13T07:50:35.840102Z","steps":["trace[1493600785] 'agreement among raft nodes before linearized reading' (duration: 2.353884725s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:35.840216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:33.486012Z","time spent":"2.35419056s","remote":"127.0.0.1:41726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":5920,"request content":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" "} {"level":"info","ts":"2026-08-13T07:50:35.839691Z","caller":"traceutil/trace.go:171","msg":"trace[280833016] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:324; }","duration":"2.353603321s","start":"2026-08-13T07:50:33.486061Z","end":"2026-08-13T07:50:35.839664Z","steps":["trace[280833016] 'read index received' (duration: 929.910329ms)","trace[280833016] 'applied index is now lower than readState.Index' (duration: 1.423691232s)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:50:35.840897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.692038376s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-13T07:50:35.840969Z","caller":"traceutil/trace.go:171","msg":"trace[664701478] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:316; }","duration":"1.692149338s","start":"2026-08-13T07:50:34.1488Z","end":"2026-08-13T07:50:35.840949Z","steps":["trace[664701478] 'agreement among raft nodes before linearized reading' (duration: 1.691966765s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:35.841028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:34.148758Z","time spent":"1.69225659s","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T07:50:35.841072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.772443004s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:50:35.841169Z","caller":"traceutil/trace.go:171","msg":"trace[553164624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:316; }","duration":"1.772575166s","start":"2026-08-13T07:50:34.068574Z","end":"2026-08-13T07:50:35.841149Z","steps":["trace[553164624] 'agreement among raft nodes before linearized reading' (duration: 1.772230841s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:35.841248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:34.06854Z","time spent":"1.772693618s","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-13T07:50:35.841237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.127428592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:50:35.841388Z","caller":"traceutil/trace.go:171","msg":"trace[1641720729] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:316; }","duration":"2.127637476s","start":"2026-08-13T07:50:33.713685Z","end":"2026-08-13T07:50:35.841323Z","steps":["trace[1641720729] 'agreement among raft nodes before linearized reading' (duration: 2.127052967s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:35.842018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:50:33.713628Z","time spent":"2.128342887s","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-13T07:50:36.006163Z","caller":"traceutil/trace.go:171","msg":"trace[1333313663] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"159.386292ms","start":"2026-08-13T07:50:35.846735Z","end":"2026-08-13T07:50:36.006121Z","steps":["trace[1333313663] 'process raft request' (duration: 91.513978ms)","trace[1333313663] 'compare' (duration: 67.60398ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:50:36.006408Z","caller":"traceutil/trace.go:171","msg":"trace[1878394566] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"159.344532ms","start":"2026-08-13T07:50:35.847007Z","end":"2026-08-13T07:50:36.006351Z","steps":["trace[1878394566] 'process raft request' (duration: 159.025137ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:50:36.006779Z","caller":"traceutil/trace.go:171","msg":"trace[80971676] linearizableReadLoop","detail":"{readStateIndex:329; appliedIndex:326; }","duration":"158.705433ms","start":"2026-08-13T07:50:35.848058Z","end":"2026-08-13T07:50:36.006764Z","steps":["trace[80971676] 'read index received' (duration: 90.205899ms)","trace[80971676] 'applied index is now lower than readState.Index' (duration: 68.498484ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:50:36.00681Z","caller":"traceutil/trace.go:171","msg":"trace[1790371296] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"159.385033ms","start":"2026-08-13T07:50:35.847415Z","end":"2026-08-13T07:50:36.0068Z","steps":["trace[1790371296] 'process raft request' (duration: 159.226631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:50:36.006918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.832985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-08-13T07:50:36.007211Z","caller":"traceutil/trace.go:171","msg":"trace[764262734] transaction","detail":"{read_only:false; response_revision:320; number_of_response:1; }","duration":"155.274978ms","start":"2026-08-13T07:50:35.851924Z","end":"2026-08-13T07:50:36.007199Z","steps":["trace[764262734] 'process raft request' (duration: 154.78507ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:50:36.006947Z","caller":"traceutil/trace.go:171","msg":"trace[359789898] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:320; }","duration":"158.917375ms","start":"2026-08-13T07:50:35.848022Z","end":"2026-08-13T07:50:36.00694Z","steps":["trace[359789898] 'agreement among raft nodes before linearized reading' (duration: 158.807144ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:04.444333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.997073ms","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-08-13T07:51:04.444438Z","caller":"traceutil/trace.go:171","msg":"trace[1926347305] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:490; }","duration":"121.240726ms","start":"2026-08-13T07:51:04.323173Z","end":"2026-08-13T07:51:04.444414Z","steps":["trace[1926347305] 'range keys from in-memory index tree' (duration: 120.849981ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:04.444468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.083156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-13T07:51:04.444934Z","caller":"traceutil/trace.go:171","msg":"trace[1839454430] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:490; }","duration":"117.608634ms","start":"2026-08-13T07:51:04.327295Z","end":"2026-08-13T07:51:04.444904Z","steps":["trace[1839454430] 'range keys from in-memory index tree' (duration: 116.824603ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:51:10.201843Z","caller":"traceutil/trace.go:171","msg":"trace[2138342229] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"134.310984ms","start":"2026-08-13T07:51:10.067468Z","end":"2026-08-13T07:51:10.201779Z","steps":["trace[2138342229] 'process raft request' (duration: 134.084351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:10.606897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.482399ms","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-08-13T07:51:10.607025Z","caller":"traceutil/trace.go:171","msg":"trace[1075170241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:535; }","duration":"120.691151ms","start":"2026-08-13T07:51:10.486307Z","end":"2026-08-13T07:51:10.606998Z","steps":["trace[1075170241] 'range keys from in-memory index tree' (duration: 120.305376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:10.607125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.663989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-13T07:51:10.607243Z","caller":"traceutil/trace.go:171","msg":"trace[950991201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:535; }","duration":"117.848511ms","start":"2026-08-13T07:51:10.489368Z","end":"2026-08-13T07:51:10.607217Z","steps":["trace[950991201] 'range keys from in-memory index tree' (duration: 117.544337ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:10.60721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.787655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-13T07:51:10.607338Z","caller":"traceutil/trace.go:171","msg":"trace[1954674797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:535; }","duration":"296.006939ms","start":"2026-08-13T07:51:10.311295Z","end":"2026-08-13T07:51:10.607302Z","steps":["trace[1954674797] 'range keys from in-memory index tree' (duration: 295.539301ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:51:12.445333Z","caller":"traceutil/trace.go:171","msg":"trace[644877246] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"166.440999ms","start":"2026-08-13T07:51:12.27887Z","end":"2026-08-13T07:51:12.445311Z","steps":["trace[644877246] 'process raft request' (duration: 164.969438ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:29.799702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.321489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:51:29.800078Z","caller":"traceutil/trace.go:171","msg":"trace[59044622] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:683; }","duration":"165.762375ms","start":"2026-08-13T07:51:29.634224Z","end":"2026-08-13T07:51:29.799986Z","steps":["trace[59044622] 'range keys from in-memory index tree' (duration: 165.163717ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:29.799679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.962317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-dj7hm\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-08-13T07:51:29.800399Z","caller":"traceutil/trace.go:171","msg":"trace[276663801] range","detail":"{range_begin:/registry/pods/kube-system/cilium-dj7hm; range_end:; response_count:1; response_revision:683; }","duration":"252.754829ms","start":"2026-08-13T07:51:29.547538Z","end":"2026-08-13T07:51:29.800293Z","steps":["trace[276663801] 'range keys from in-memory index tree' (duration: 251.686824ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:51:29.981567Z","caller":"traceutil/trace.go:171","msg":"trace[169505736] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"159.138175ms","start":"2026-08-13T07:51:29.822323Z","end":"2026-08-13T07:51:29.981461Z","steps":["trace[169505736] 'process raft request' (duration: 158.894152ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:51:29.981603Z","caller":"traceutil/trace.go:171","msg":"trace[525815481] linearizableReadLoop","detail":"{readStateIndex:712; appliedIndex:711; }","duration":"137.524191ms","start":"2026-08-13T07:51:29.843854Z","end":"2026-08-13T07:51:29.981378Z","steps":["trace[525815481] 'read index received' (duration: 137.293348ms)","trace[525815481] 'applied index is now lower than readState.Index' (duration: 229.553µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:51:29.982096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.19362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:51:29.982151Z","caller":"traceutil/trace.go:171","msg":"trace[1376434949] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:684; }","duration":"138.338652ms","start":"2026-08-13T07:51:29.843789Z","end":"2026-08-13T07:51:29.982128Z","steps":["trace[1376434949] 'agreement among raft nodes before linearized reading' (duration: 138.105059ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:31.546579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617105856,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-13T07:51:31.760692Z","caller":"traceutil/trace.go:171","msg":"trace[1159767962] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"913.589104ms","start":"2026-08-13T07:51:30.847075Z","end":"2026-08-13T07:51:31.760664Z","steps":["trace[1159767962] 'process raft request' (duration: 913.31985ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:31.761189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:51:30.847055Z","time spent":"913.724555ms","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:51:31.974843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.529749ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:51:31.974968Z","caller":"traceutil/trace.go:171","msg":"trace[251553773] linearizableReadLoop","detail":"{readStateIndex:715; appliedIndex:713; }","duration":"929.510805ms","start":"2026-08-13T07:51:31.045438Z","end":"2026-08-13T07:51:31.974949Z","steps":["trace[251553773] 'read index received' (duration: 715.12149ms)","trace[251553773] 'applied index is now lower than readState.Index' (duration: 214.387745ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:51:31.97505Z","caller":"traceutil/trace.go:171","msg":"trace[844161690] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"1.127183718s","start":"2026-08-13T07:51:30.847811Z","end":"2026-08-13T07:51:31.974994Z","steps":["trace[844161690] 'process raft request' (duration: 1.013323925s)","trace[844161690] 'compare' (duration: 113.403307ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:51:31.975139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:51:30.847793Z","time spent":"1.12731199s","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-13T07:51:31.975187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"929.752588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-08-13T07:51:31.975171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.370692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:51:31.975222Z","caller":"traceutil/trace.go:171","msg":"trace[1818479818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:687; }","duration":"929.832389ms","start":"2026-08-13T07:51:31.045378Z","end":"2026-08-13T07:51:31.97521Z","steps":["trace[1818479818] 'agreement among raft nodes before linearized reading' (duration: 929.683937ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:51:31.97527Z","caller":"traceutil/trace.go:171","msg":"trace[1128852169] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:687; }","duration":"340.516985ms","start":"2026-08-13T07:51:31.634728Z","end":"2026-08-13T07:51:31.975245Z","steps":["trace[1128852169] 'agreement among raft nodes before linearized reading' (duration: 340.362703ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:31.975296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:51:31.045358Z","time spent":"929.92433ms","remote":"127.0.0.1:41800","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-08-13T07:51:31.975348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:51:31.634711Z","time spent":"340.624636ms","remote":"127.0.0.1:41526","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-08-13T07:51:32.5925Z","caller":"traceutil/trace.go:171","msg":"trace[1804868021] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"612.290813ms","start":"2026-08-13T07:51:31.980182Z","end":"2026-08-13T07:51:32.592473Z","steps":["trace[1804868021] 'process raft request' (duration: 607.595849ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:51:32.592463Z","caller":"traceutil/trace.go:171","msg":"trace[1639845763] linearizableReadLoop","detail":"{readStateIndex:716; appliedIndex:715; }","duration":"104.97284ms","start":"2026-08-13T07:51:32.487452Z","end":"2026-08-13T07:51:32.592425Z","steps":["trace[1639845763] 'read index received' (duration: 100.228176ms)","trace[1639845763] 'applied index is now lower than readState.Index' (duration: 4.743144ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:51:32.592647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:51:31.980161Z","time spent":"612.410384ms","remote":"127.0.0.1:41800","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-08-13T07:51:32.592827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.346575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T07:51:32.592886Z","caller":"traceutil/trace.go:171","msg":"trace[2031077018] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:688; }","duration":"105.466877ms","start":"2026-08-13T07:51:32.487403Z","end":"2026-08-13T07:51:32.59287Z","steps":["trace[2031077018] 'agreement among raft nodes before linearized reading' (duration: 105.210133ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:33.981572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.791427ms","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-08-13T07:51:33.981695Z","caller":"traceutil/trace.go:171","msg":"trace[1708119883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:695; }","duration":"214.008029ms","start":"2026-08-13T07:51:33.767662Z","end":"2026-08-13T07:51:33.98167Z","steps":["trace[1708119883] 'range keys from in-memory index tree' (duration: 213.505863ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:51:38.02977Z","caller":"traceutil/trace.go:171","msg":"trace[2092147713] linearizableReadLoop","detail":"{readStateIndex:787; appliedIndex:786; }","duration":"108.18436ms","start":"2026-08-13T07:51:37.921567Z","end":"2026-08-13T07:51:38.029752Z","steps":["trace[2092147713] 'read index received' (duration: 108.064909ms)","trace[2092147713] 'applied index is now lower than readState.Index' (duration: 118.961µs)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:51:38.029956Z","caller":"traceutil/trace.go:171","msg":"trace[2033710333] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"119.606323ms","start":"2026-08-13T07:51:37.910289Z","end":"2026-08-13T07:51:38.029895Z","steps":["trace[2033710333] 'process raft request' (duration: 119.323589ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:38.030216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.550085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:51:38.030388Z","caller":"traceutil/trace.go:171","msg":"trace[11445545] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:758; }","duration":"108.761327ms","start":"2026-08-13T07:51:37.921601Z","end":"2026-08-13T07:51:38.030362Z","steps":["trace[11445545] 'agreement among raft nodes before linearized reading' (duration: 108.463013ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:38.030768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.106562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:51:38.030836Z","caller":"traceutil/trace.go:171","msg":"trace[1674384783] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:758; }","duration":"109.197784ms","start":"2026-08-13T07:51:37.921624Z","end":"2026-08-13T07:51:38.030822Z","steps":["trace[1674384783] 'agreement among raft nodes before linearized reading' (duration: 109.091452ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:51:38.031801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.206797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:51:38.032473Z","caller":"traceutil/trace.go:171","msg":"trace[2049731181] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:758; }","duration":"110.391119ms","start":"2026-08-13T07:51:37.921516Z","end":"2026-08-13T07:51:38.031907Z","steps":["trace[2049731181] 'agreement among raft nodes before linearized reading' (duration: 108.359322ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:52:06.656824Z","caller":"traceutil/trace.go:171","msg":"trace[1602605511] linearizableReadLoop","detail":"{readStateIndex:929; appliedIndex:928; }","duration":"434.956797ms","start":"2026-08-13T07:52:06.221822Z","end":"2026-08-13T07:52:06.656779Z","steps":["trace[1602605511] 'read index received' (duration: 434.831036ms)","trace[1602605511] 'applied index is now lower than readState.Index' (duration: 124.831µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:52:06.657184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.265619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:52:06.657222Z","caller":"traceutil/trace.go:171","msg":"trace[678570486] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:893; }","duration":"434.33824ms","start":"2026-08-13T07:52:06.222871Z","end":"2026-08-13T07:52:06.657209Z","steps":["trace[678570486] 'agreement among raft nodes before linearized reading' (duration: 434.113117ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:06.657248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:06.222799Z","time spent":"434.44098ms","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-13T07:52:06.657255Z","caller":"traceutil/trace.go:171","msg":"trace[1545072327] transaction","detail":"{read_only:false; response_revision:893; number_of_response:1; }","duration":"901.454224ms","start":"2026-08-13T07:52:05.755637Z","end":"2026-08-13T07:52:06.657091Z","steps":["trace[1545072327] 'process raft request' (duration: 900.974138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:06.657285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.428663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-13T07:52:06.657469Z","caller":"traceutil/trace.go:171","msg":"trace[1220487207] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:893; }","duration":"435.685897ms","start":"2026-08-13T07:52:06.221754Z","end":"2026-08-13T07:52:06.65744Z","steps":["trace[1220487207] 'agreement among raft nodes before linearized reading' (duration: 435.210951ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:06.657553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:06.221731Z","time spent":"435.808008ms","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-13T07:52:06.657521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.237899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:52:06.657685Z","caller":"traceutil/trace.go:171","msg":"trace[849305170] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:893; }","duration":"281.507933ms","start":"2026-08-13T07:52:06.376149Z","end":"2026-08-13T07:52:06.657656Z","steps":["trace[849305170] 'agreement among raft nodes before linearized reading' (duration: 280.990776ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:52:06.657925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:52:05.755597Z","time spent":"901.963ms","remote":"127.0.0.1:41726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:53:09.462686Z","caller":"traceutil/trace.go:171","msg":"trace[1469911706] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"267.259673ms","start":"2026-08-13T07:53:09.195356Z","end":"2026-08-13T07:53:09.462616Z","steps":["trace[1469911706] 'process raft request' (duration: 267.062551ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:53:09.51546Z","caller":"traceutil/trace.go:171","msg":"trace[1648637036] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1278; }","duration":"218.434314ms","start":"2026-08-13T07:53:09.296975Z","end":"2026-08-13T07:53:09.515409Z","steps":["trace[1648637036] 'read index received' (duration: 165.522934ms)","trace[1648637036] 'applied index is now lower than readState.Index' (duration: 52.91014ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:53:09.515505Z","caller":"traceutil/trace.go:171","msg":"trace[7881526] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"290.932714ms","start":"2026-08-13T07:53:09.224518Z","end":"2026-08-13T07:53:09.515451Z","steps":["trace[7881526] 'process raft request' (duration: 290.665881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:53:09.51717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.023017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-13T07:53:09.517283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.300577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-13T07:53:09.517293Z","caller":"traceutil/trace.go:171","msg":"trace[763391738] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1231; }","duration":"209.22746ms","start":"2026-08-13T07:53:09.308015Z","end":"2026-08-13T07:53:09.517242Z","steps":["trace[763391738] 'agreement among raft nodes before linearized reading' (duration: 207.59897ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:53:09.517331Z","caller":"traceutil/trace.go:171","msg":"trace[1652799788] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1231; }","duration":"220.391998ms","start":"2026-08-13T07:53:09.296916Z","end":"2026-08-13T07:53:09.517308Z","steps":["trace[1652799788] 'agreement among raft nodes before linearized reading' (duration: 218.605406ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:54:09.3588Z","caller":"traceutil/trace.go:171","msg":"trace[417875662] transaction","detail":"{read_only:false; response_revision:1443; number_of_response:1; }","duration":"135.052921ms","start":"2026-08-13T07:54:09.2237Z","end":"2026-08-13T07:54:09.358753Z","steps":["trace[417875662] 'process raft request' (duration: 36.610493ms)","trace[417875662] 'compare' (duration: 98.223536ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:54:09.747354Z","caller":"traceutil/trace.go:171","msg":"trace[840243043] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"139.273092ms","start":"2026-08-13T07:54:09.608053Z","end":"2026-08-13T07:54:09.747326Z","steps":["trace[840243043] 'process raft request' (duration: 138.558043ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:10.113689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.419665ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-13T07:54:10.113946Z","caller":"traceutil/trace.go:171","msg":"trace[259405301] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"181.240498ms","start":"2026-08-13T07:54:09.932684Z","end":"2026-08-13T07:54:10.113925Z","steps":["trace[259405301] 'process raft request' (duration: 74.256297ms)","trace[259405301] 'compare' (duration: 106.135171ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:54:10.114026Z","caller":"traceutil/trace.go:171","msg":"trace[1587872197] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"181.324039ms","start":"2026-08-13T07:54:09.932684Z","end":"2026-08-13T07:54:10.114008Z","steps":["trace[1587872197] 'process raft request' (duration: 181.199958ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:18.777255Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617107826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:54:19.277636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617107826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:54:19.778353Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617107826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:54:20.282375Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617107826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:54:20.837217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.202656627s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-13T07:54:20.837341Z","caller":"traceutil/trace.go:171","msg":"trace[534328695] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.202808309s","start":"2026-08-13T07:54:18.634474Z","end":"2026-08-13T07:54:20.837282Z","steps":["trace[534328695] 'agreement among raft nodes before linearized reading' (duration: 2.202707798s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:20.837394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:18.634446Z","time spent":"2.202941211s","remote":"127.0.0.1:41526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/13 07:54:20 WARNING: [core] [Server #6] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-13T07:54:20.838243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617107826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:54:21.612679Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617107826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:54:22.878107Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1558139892617107826,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-13T07:54:22.878413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.032157647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-13T07:54:22.878475Z","caller":"traceutil/trace.go:171","msg":"trace[600944922] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.032241788s","start":"2026-08-13T07:54:20.846213Z","end":"2026-08-13T07:54:22.878455Z","steps":["trace[600944922] 'agreement among raft nodes before linearized reading' (duration: 2.032154047s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:22.878528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:20.846193Z","time spent":"2.032327148s","remote":"127.0.0.1:41526","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-13T07:54:22.879239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.04155953s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-13T07:54:22.879275Z","caller":"traceutil/trace.go:171","msg":"trace[791553642] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.04162502s","start":"2026-08-13T07:54:20.837631Z","end":"2026-08-13T07:54:22.879256Z","steps":["trace[791553642] 'agreement among raft nodes before linearized reading' (duration: 2.04159716s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:22.879294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:20.837616Z","time spent":"2.041673372s","remote":"127.0.0.1:41534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-13T07:54:23.025265Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.852938371s","expected-duration":"1s"} {"level":"info","ts":"2026-08-13T07:54:23.025841Z","caller":"traceutil/trace.go:171","msg":"trace[471148490] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"4.853623158s","start":"2026-08-13T07:54:18.172188Z","end":"2026-08-13T07:54:23.025812Z","steps":["trace[471148490] 'process raft request' (duration: 4.853364435s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.02601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:18.172154Z","time spent":"4.853759531s","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:54:23.139096Z","caller":"traceutil/trace.go:171","msg":"trace[254318566] linearizableReadLoop","detail":"{readStateIndex:1557; appliedIndex:1555; }","duration":"4.862678867s","start":"2026-08-13T07:54:18.276385Z","end":"2026-08-13T07:54:23.139064Z","steps":["trace[254318566] 'read index received' (duration: 4.749753836s)","trace[254318566] 'applied index is now lower than readState.Index' (duration: 112.924161ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:54:23.139319Z","caller":"traceutil/trace.go:171","msg":"trace[1332744656] transaction","detail":"{read_only:false; response_revision:1492; number_of_response:1; }","duration":"4.965901081s","start":"2026-08-13T07:54:18.173407Z","end":"2026-08-13T07:54:23.139308Z","steps":["trace[1332744656] 'process raft request' (duration: 4.965022921s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.139433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:18.173392Z","time spent":"4.965959443s","remote":"127.0.0.1:41800","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-08-13T07:54:23.139597Z","caller":"traceutil/trace.go:171","msg":"trace[1020269537] transaction","detail":"{read_only:false; response_revision:1493; number_of_response:1; }","duration":"4.275995783s","start":"2026-08-13T07:54:18.863592Z","end":"2026-08-13T07:54:23.139588Z","steps":["trace[1020269537] 'process raft request' (duration: 4.275313194s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.139647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:18.86355Z","time spent":"4.276072184s","remote":"127.0.0.1:41800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-13T07:54:23.139744Z","caller":"traceutil/trace.go:171","msg":"trace[1036949085] transaction","detail":"{read_only:false; response_revision:1494; number_of_response:1; }","duration":"246.859357ms","start":"2026-08-13T07:54:22.892876Z","end":"2026-08-13T07:54:23.139736Z","steps":["trace[1036949085] 'process raft request' (duration: 246.121018ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:54:23.139864Z","caller":"traceutil/trace.go:171","msg":"trace[1507431918] transaction","detail":"{read_only:false; response_revision:1495; number_of_response:1; }","duration":"246.505063ms","start":"2026-08-13T07:54:22.89335Z","end":"2026-08-13T07:54:23.139855Z","steps":["trace[1507431918] 'process raft request' (duration: 245.685173ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.140936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.792652543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" ","response":"range_response_count:1 size:1465"} {"level":"info","ts":"2026-08-13T07:54:23.141033Z","caller":"traceutil/trace.go:171","msg":"trace[1791942478] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/test-pvc; range_end:; response_count:1; response_revision:1495; }","duration":"4.792774325s","start":"2026-08-13T07:54:18.348236Z","end":"2026-08-13T07:54:23.14101Z","steps":["trace[1791942478] 'agreement among raft nodes before linearized reading' (duration: 4.792476801s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.141193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:18.348162Z","time spent":"4.793019638s","remote":"127.0.0.1:41698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":51,"response count":1,"response size":1488,"request content":"key:\"/registry/persistentvolumeclaims/default/test-pvc\" "} {"level":"warn","ts":"2026-08-13T07:54:23.144434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.248258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:54:23.144493Z","caller":"traceutil/trace.go:171","msg":"trace[1198343506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1495; }","duration":"245.343848ms","start":"2026-08-13T07:54:22.899128Z","end":"2026-08-13T07:54:23.144472Z","steps":["trace[1198343506] 'agreement among raft nodes before linearized reading' (duration: 245.225497ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.144701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.011623999s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-13T07:54:23.14474Z","caller":"traceutil/trace.go:171","msg":"trace[1562126771] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1495; }","duration":"3.011715949s","start":"2026-08-13T07:54:20.133012Z","end":"2026-08-13T07:54:23.144728Z","steps":["trace[1562126771] 'agreement among raft nodes before linearized reading' (duration: 3.011662969s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.144792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:20.132993Z","time spent":"3.011770821s","remote":"127.0.0.1:40394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:54:23.144994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.184473133s","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-08-13T07:54:23.145013Z","caller":"traceutil/trace.go:171","msg":"trace[933171739] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1495; }","duration":"3.184533013s","start":"2026-08-13T07:54:19.960474Z","end":"2026-08-13T07:54:23.145007Z","steps":["trace[933171739] 'agreement among raft nodes before linearized reading' (duration: 3.184430092s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.145028Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:19.960457Z","time spent":"3.184567764s","remote":"127.0.0.1:41800","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-08-13T07:54:23.145221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.348086335s","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-08-13T07:54:23.145243Z","caller":"traceutil/trace.go:171","msg":"trace[1012101137] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1495; }","duration":"3.348173246s","start":"2026-08-13T07:54:19.797064Z","end":"2026-08-13T07:54:23.145237Z","steps":["trace[1012101137] 'agreement among raft nodes before linearized reading' (duration: 3.348016834s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.145264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:19.797049Z","time spent":"3.348208277s","remote":"127.0.0.1:41800","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-08-13T07:54:23.145367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.480866566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-08-13T07:54:23.145383Z","caller":"traceutil/trace.go:171","msg":"trace[1616530472] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1495; }","duration":"3.480925656s","start":"2026-08-13T07:54:19.664451Z","end":"2026-08-13T07:54:23.145377Z","steps":["trace[1616530472] 'agreement among raft nodes before linearized reading' (duration: 3.480857355s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.145402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:19.664431Z","time spent":"3.480964007s","remote":"127.0.0.1:41800","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-08-13T07:54:23.145885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.359453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2476"} {"level":"info","ts":"2026-08-13T07:54:23.145913Z","caller":"traceutil/trace.go:171","msg":"trace[1872686455] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1495; }","duration":"252.416125ms","start":"2026-08-13T07:54:22.893492Z","end":"2026-08-13T07:54:23.145908Z","steps":["trace[1872686455] 'agreement among raft nodes before linearized reading' (duration: 252.329234ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.146113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.505935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:54:23.146139Z","caller":"traceutil/trace.go:171","msg":"trace[810155808] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1495; }","duration":"252.588876ms","start":"2026-08-13T07:54:22.893542Z","end":"2026-08-13T07:54:23.146131Z","steps":["trace[810155808] 'agreement among raft nodes before linearized reading' (duration: 252.498605ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.146266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.744528ms","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-08-13T07:54:23.146286Z","caller":"traceutil/trace.go:171","msg":"trace[809084748] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1495; }","duration":"252.775128ms","start":"2026-08-13T07:54:22.893505Z","end":"2026-08-13T07:54:23.14628Z","steps":["trace[809084748] 'agreement among raft nodes before linearized reading' (duration: 252.743968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.146723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.308811644s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.102\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-13T07:54:23.146742Z","caller":"traceutil/trace.go:171","msg":"trace[64504779] range","detail":"{range_begin:/registry/masterleases/199.19.213.102; range_end:; response_count:1; response_revision:1495; }","duration":"2.308838165s","start":"2026-08-13T07:54:20.837898Z","end":"2026-08-13T07:54:23.146736Z","steps":["trace[64504779] 'agreement among raft nodes before linearized reading' (duration: 2.308755874s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.146765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:20.837895Z","time spent":"2.308858465s","remote":"127.0.0.1:41566","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.102\" "} {"level":"warn","ts":"2026-08-13T07:54:23.146925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.309092168s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-13T07:54:23.146944Z","caller":"traceutil/trace.go:171","msg":"trace[1130561631] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1495; }","duration":"2.309121978s","start":"2026-08-13T07:54:20.837816Z","end":"2026-08-13T07:54:23.146938Z","steps":["trace[1130561631] 'agreement among raft nodes before linearized reading' (duration: 2.309077247s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.14696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:20.837812Z","time spent":"2.309142598s","remote":"127.0.0.1:41698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":30,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-08-13T07:54:23.153077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.876655985s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2476"} {"level":"info","ts":"2026-08-13T07:54:23.153176Z","caller":"traceutil/trace.go:171","msg":"trace[1364700196] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1495; }","duration":"4.876817077s","start":"2026-08-13T07:54:18.27634Z","end":"2026-08-13T07:54:23.153157Z","steps":["trace[1364700196] 'agreement among raft nodes before linearized reading' (duration: 4.863629528s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.15322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:18.276324Z","time spent":"4.876887259s","remote":"127.0.0.1:41726","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2499,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"warn","ts":"2026-08-13T07:54:23.144495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.306697999s","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-08-13T07:54:23.162007Z","caller":"traceutil/trace.go:171","msg":"trace[1552874963] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:1495; }","duration":"2.324162919s","start":"2026-08-13T07:54:20.837737Z","end":"2026-08-13T07:54:23.1619Z","steps":["trace[1552874963] 'agreement among raft nodes before linearized reading' (duration: 2.306670359s)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:23.162224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-13T07:54:20.837732Z","time spent":"2.324413082s","remote":"127.0.0.1:40568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-08-13T07:54:29.377225Z","caller":"traceutil/trace.go:171","msg":"trace[1602441650] transaction","detail":"{read_only:false; response_revision:1520; number_of_response:1; }","duration":"150.725355ms","start":"2026-08-13T07:54:29.226446Z","end":"2026-08-13T07:54:29.377171Z","steps":["trace[1602441650] 'process raft request' (duration: 150.553633ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:54:29.377464Z","caller":"traceutil/trace.go:171","msg":"trace[1364831641] linearizableReadLoop","detail":"{readStateIndex:1586; appliedIndex:1586; }","duration":"149.706052ms","start":"2026-08-13T07:54:29.227746Z","end":"2026-08-13T07:54:29.377452Z","steps":["trace[1364831641] 'read index received' (duration: 149.700842ms)","trace[1364831641] 'applied index is now lower than readState.Index' (duration: 4.23µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:54:29.377624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.781353ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-13T07:54:29.377662Z","caller":"traceutil/trace.go:171","msg":"trace[1986673250] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1520; }","duration":"149.845685ms","start":"2026-08-13T07:54:29.227804Z","end":"2026-08-13T07:54:29.37765Z","steps":["trace[1986673250] 'agreement among raft nodes before linearized reading' (duration: 149.702333ms)"],"step_count":1} {"level":"warn","ts":"2026-08-13T07:54:29.377875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.112517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-08-13T07:54:29.377994Z","caller":"traceutil/trace.go:171","msg":"trace[960726639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1520; }","duration":"150.289299ms","start":"2026-08-13T07:54:29.227678Z","end":"2026-08-13T07:54:29.377967Z","steps":["trace[960726639] 'agreement among raft nodes before linearized reading' (duration: 150.035356ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:54:45.420015Z","caller":"traceutil/trace.go:171","msg":"trace[1694285494] linearizableReadLoop","detail":"{readStateIndex:1646; appliedIndex:1645; }","duration":"128.635086ms","start":"2026-08-13T07:54:45.291265Z","end":"2026-08-13T07:54:45.4199Z","steps":["trace[1694285494] 'read index received' (duration: 108.621025ms)","trace[1694285494] 'applied index is now lower than readState.Index' (duration: 20.012111ms)"],"step_count":2} {"level":"info","ts":"2026-08-13T07:54:45.420027Z","caller":"traceutil/trace.go:171","msg":"trace[303248962] transaction","detail":"{read_only:false; response_revision:1577; number_of_response:1; }","duration":"129.139282ms","start":"2026-08-13T07:54:45.290815Z","end":"2026-08-13T07:54:45.419954Z","steps":["trace[303248962] 'process raft request' (duration: 109.085211ms)","trace[303248962] 'compare' (duration: 19.841699ms)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:54:45.420324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.00223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:775"} {"level":"info","ts":"2026-08-13T07:54:45.420444Z","caller":"traceutil/trace.go:171","msg":"trace[1442597209] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:1577; }","duration":"129.203403ms","start":"2026-08-13T07:54:45.291213Z","end":"2026-08-13T07:54:45.420417Z","steps":["trace[1442597209] 'agreement among raft nodes before linearized reading' (duration: 128.95395ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:54:49.316919Z","caller":"traceutil/trace.go:171","msg":"trace[1864805046] transaction","detail":"{read_only:false; response_revision:1588; number_of_response:1; }","duration":"103.963309ms","start":"2026-08-13T07:54:49.212913Z","end":"2026-08-13T07:54:49.316876Z","steps":["trace[1864805046] 'process raft request' (duration: 103.688246ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:00.969705Z","caller":"traceutil/trace.go:171","msg":"trace[1025976717] linearizableReadLoop","detail":"{readStateIndex:1699; appliedIndex:1698; }","duration":"127.490781ms","start":"2026-08-13T07:55:00.842184Z","end":"2026-08-13T07:55:00.969675Z","steps":["trace[1025976717] 'read index received' (duration: 127.179433ms)","trace[1025976717] 'applied index is now lower than readState.Index' (duration: 310.298µs)"],"step_count":2} {"level":"warn","ts":"2026-08-13T07:55:00.969912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.710411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-rre434\" ","response":"range_response_count:1 size:692"} {"level":"info","ts":"2026-08-13T07:55:00.969962Z","caller":"traceutil/trace.go:171","msg":"trace[783399755] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-rre434; range_end:; response_count:1; response_revision:1626; }","duration":"127.831492ms","start":"2026-08-13T07:55:00.842117Z","end":"2026-08-13T07:55:00.969949Z","steps":["trace[783399755] 'agreement among raft nodes before linearized reading' (duration: 127.69575ms)"],"step_count":1} {"level":"info","ts":"2026-08-13T07:55:04.229131Z","caller":"traceutil/trace.go:171","msg":"trace[2100032122] transaction","detail":"{read_only:false; response_revision:1640; number_of_response:1; }","duration":"143.805223ms","start":"2026-08-13T07:55:04.085302Z","end":"2026-08-13T07:55:04.229107Z","steps":["trace[2100032122] 'process raft request' (duration: 143.588984ms)"],"step_count":1}