{"level":"warn","ts":"2026-05-19T00:06:09.595557Z","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-19T00:06:09.595645Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109: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-19T00:06:09.595711Z","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-19T00:06:09.595724Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-19T00:06:09.595741Z","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-19T00:06:09.596354Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-05-19T00:06:09.596427Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109: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-19T00:06:09.602074Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.445571ms"} {"level":"info","ts":"2026-05-19T00:06:09.61042Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-05-19T00:06:09.610488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-05-19T00:06:09.610511Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-05-19T00:06:09.61052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-19T00:06:09.610538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-05-19T00:06:09.610576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-05-19T00:06:09.620911Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-19T00:06:09.625397Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-19T00:06:09.626537Z","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-19T00:06:09.628623Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-19T00:06:09.628839Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-19T00:06:09.629209Z","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-19T00:06:09.629325Z","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-19T00:06:09.629341Z","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-19T00:06:09.629866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-05-19T00:06:09.631179Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-05-19T00:06:09.632881Z","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-19T00:06:09.633093Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-19T00:06:09.633232Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-19T00:06:09.633342Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-19T00:06:09.633352Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-05-19T00:06:09.71109Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-05-19T00:06:09.711282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-05-19T00:06:09.711368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-05-19T00:06:09.711423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-05-19T00:06:09.711481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-19T00:06:09.711566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-05-19T00:06:09.71161Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-05-19T00:06:09.712476Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:09.713336Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T00:06:09.71334Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-05-19T00:06:09.713358Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-19T00:06:09.713848Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-19T00:06:09.714007Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-19T00:06:09.71459Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:09.714822Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:09.714918Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-19T00:06:09.717492Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-05-19T00:06:09.717556Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-19T00:06:17.364655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"552.792768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-19T00:06:17.364754Z","caller":"traceutil/trace.go:171","msg":"trace[667956766] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:278; }","duration":"552.954312ms","start":"2026-05-19T00:06:16.811783Z","end":"2026-05-19T00:06:17.364737Z","steps":["trace[667956766] 'range keys from in-memory index tree' (duration: 552.546052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:17.36479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:16.811755Z","time spent":"553.028394ms","remote":"127.0.0.1:43960","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":"warn","ts":"2026-05-19T00:06:18.022491Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367768453827736,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-19T00:06:18.512557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.110123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:06:18.512668Z","caller":"traceutil/trace.go:171","msg":"trace[2096065109] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:292; }","duration":"990.682798ms","start":"2026-05-19T00:06:17.521968Z","end":"2026-05-19T00:06:18.512651Z","steps":["trace[2096065109] 'read index received' (duration: 612.033463ms)","trace[2096065109] 'applied index is now lower than readState.Index' (duration: 378.648065ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:18.512749Z","caller":"traceutil/trace.go:171","msg":"trace[2119049161] transaction","detail":"{read_only:false; response_revision:280; number_of_response:1; }","duration":"1.067629989s","start":"2026-05-19T00:06:17.445109Z","end":"2026-05-19T00:06:18.512739Z","steps":["trace[2119049161] 'process raft request' (duration: 688.863851ms)","trace[2119049161] 'compare' (duration: 377.97187ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:18.512807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:17.445096Z","time spent":"1.06768747s","remote":"127.0.0.1:44068","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":197,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T00:06:18.513086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.321745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-19T00:06:18.513136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.380447ms","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-05-19T00:06:18.513182Z","caller":"traceutil/trace.go:171","msg":"trace[815134745] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:280; }","duration":"271.454519ms","start":"2026-05-19T00:06:18.241718Z","end":"2026-05-19T00:06:18.513172Z","steps":["trace[815134745] 'agreement among raft nodes before linearized reading' (duration: 271.372577ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:18.513188Z","caller":"traceutil/trace.go:171","msg":"trace[647492287] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:280; }","duration":"924.490869ms","start":"2026-05-19T00:06:17.588677Z","end":"2026-05-19T00:06:18.513168Z","steps":["trace[647492287] 'agreement among raft nodes before linearized reading' (duration: 924.266624ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:18.513234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:17.588657Z","time spent":"924.5679ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T00:06:18.513267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.209741ms","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-05-19T00:06:18.513441Z","caller":"traceutil/trace.go:171","msg":"trace[1676578179] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:280; }","duration":"991.479187ms","start":"2026-05-19T00:06:17.521915Z","end":"2026-05-19T00:06:18.513394Z","steps":["trace[1676578179] 'agreement among raft nodes before linearized reading' (duration: 991.045767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:18.513526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:17.521895Z","time spent":"991.609579ms","remote":"127.0.0.1:44148","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-05-19T00:06:19.21639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.774464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:06:19.216579Z","caller":"traceutil/trace.go:171","msg":"trace[197201659] linearizableReadLoop","detail":"{readStateIndex:296; appliedIndex:293; }","duration":"697.184957ms","start":"2026-05-19T00:06:18.519377Z","end":"2026-05-19T00:06:19.216562Z","steps":["trace[197201659] 'read index received' (duration: 40.199538ms)","trace[197201659] 'applied index is now lower than readState.Index' (duration: 656.984629ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:19.216665Z","caller":"traceutil/trace.go:171","msg":"trace[1438846627] transaction","detail":"{read_only:false; response_revision:282; number_of_response:1; }","duration":"699.402857ms","start":"2026-05-19T00:06:18.51725Z","end":"2026-05-19T00:06:19.216653Z","steps":["trace[1438846627] 'process raft request' (duration: 534.138152ms)","trace[1438846627] 'compare' (duration: 164.655091ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:19.216741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:18.517226Z","time spent":"699.480988ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:06:19.216912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"697.522634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-19T00:06:19.216922Z","caller":"traceutil/trace.go:171","msg":"trace[273600241] transaction","detail":"{read_only:false; response_revision:283; number_of_response:1; }","duration":"698.19415ms","start":"2026-05-19T00:06:18.518695Z","end":"2026-05-19T00:06:19.216889Z","steps":["trace[273600241] 'process raft request' (duration: 697.814402ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:19.216969Z","caller":"traceutil/trace.go:171","msg":"trace[439749263] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:283; }","duration":"697.601056ms","start":"2026-05-19T00:06:18.519352Z","end":"2026-05-19T00:06:19.216953Z","steps":["trace[439749263] 'agreement among raft nodes before linearized reading' (duration: 697.474104ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:19.217006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:18.519343Z","time spent":"697.655697ms","remote":"127.0.0.1:43960","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":"warn","ts":"2026-05-19T00:06:19.216942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.345225ms","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-19T00:06:19.217089Z","caller":"traceutil/trace.go:171","msg":"trace[1902043730] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:283; }","duration":"665.528859ms","start":"2026-05-19T00:06:18.551547Z","end":"2026-05-19T00:06:19.217076Z","steps":["trace[1902043730] 'agreement among raft nodes before linearized reading' (duration: 665.350195ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:19.21709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:18.518676Z","time spent":"698.323362ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:06:19.217119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:18.551462Z","time spent":"665.648792ms","remote":"127.0.0.1:44148","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-19T00:06:39.507621Z","caller":"traceutil/trace.go:171","msg":"trace[676320534] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"291.149049ms","start":"2026-05-19T00:06:39.216447Z","end":"2026-05-19T00:06:39.507596Z","steps":["trace[676320534] 'process raft request' (duration: 291.012126ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.518486Z","caller":"traceutil/trace.go:171","msg":"trace[1454224554] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"299.067626ms","start":"2026-05-19T00:06:39.219405Z","end":"2026-05-19T00:06:39.518473Z","steps":["trace[1454224554] 'process raft request' (duration: 298.699918ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.518585Z","caller":"traceutil/trace.go:171","msg":"trace[1623412245] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"272.40442ms","start":"2026-05-19T00:06:39.246164Z","end":"2026-05-19T00:06:39.518568Z","steps":["trace[1623412245] 'process raft request' (duration: 272.239816ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.518603Z","caller":"traceutil/trace.go:171","msg":"trace[2014151103] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"289.83329ms","start":"2026-05-19T00:06:39.228734Z","end":"2026-05-19T00:06:39.518568Z","steps":["trace[2014151103] 'process raft request' (duration: 289.603725ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.51858Z","caller":"traceutil/trace.go:171","msg":"trace[511950498] transaction","detail":"{read_only:false; response_revision:467; number_of_response:1; }","duration":"279.527669ms","start":"2026-05-19T00:06:39.239008Z","end":"2026-05-19T00:06:39.518535Z","steps":["trace[511950498] 'process raft request' (duration: 279.363356ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.518707Z","caller":"traceutil/trace.go:171","msg":"trace[1173429305] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"272.42373ms","start":"2026-05-19T00:06:39.246275Z","end":"2026-05-19T00:06:39.518699Z","steps":["trace[1173429305] 'process raft request' (duration: 272.167274ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.518758Z","caller":"traceutil/trace.go:171","msg":"trace[316467809] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"264.82346ms","start":"2026-05-19T00:06:39.253926Z","end":"2026-05-19T00:06:39.518749Z","steps":["trace[316467809] 'process raft request' (duration: 264.566514ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.518819Z","caller":"traceutil/trace.go:171","msg":"trace[330983518] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"264.83489ms","start":"2026-05-19T00:06:39.253975Z","end":"2026-05-19T00:06:39.51881Z","steps":["trace[330983518] 'process raft request' (duration: 264.631896ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.518924Z","caller":"traceutil/trace.go:171","msg":"trace[1305915023] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"253.408965ms","start":"2026-05-19T00:06:39.265507Z","end":"2026-05-19T00:06:39.518916Z","steps":["trace[1305915023] 'process raft request' (duration: 253.19425ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.519039Z","caller":"traceutil/trace.go:171","msg":"trace[1263761935] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"249.908297ms","start":"2026-05-19T00:06:39.269121Z","end":"2026-05-19T00:06:39.51903Z","steps":["trace[1263761935] 'process raft request' (duration: 249.706693ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.519144Z","caller":"traceutil/trace.go:171","msg":"trace[1014768316] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"229.89167ms","start":"2026-05-19T00:06:39.289245Z","end":"2026-05-19T00:06:39.519137Z","steps":["trace[1014768316] 'process raft request' (duration: 229.696965ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.519829Z","caller":"traceutil/trace.go:171","msg":"trace[2053509979] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:482; }","duration":"195.757276ms","start":"2026-05-19T00:06:39.32406Z","end":"2026-05-19T00:06:39.519817Z","steps":["trace[2053509979] 'read index received' (duration: 183.503552ms)","trace[2053509979] 'applied index is now lower than readState.Index' (duration: 12.252514ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:39.519914Z","caller":"traceutil/trace.go:171","msg":"trace[173806252] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"134.723102ms","start":"2026-05-19T00:06:39.385181Z","end":"2026-05-19T00:06:39.519904Z","steps":["trace[173806252] 'process raft request' (duration: 134.008006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.520112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.029803ms","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-05-19T00:06:39.520142Z","caller":"traceutil/trace.go:171","msg":"trace[2085452279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"196.114934ms","start":"2026-05-19T00:06:39.32402Z","end":"2026-05-19T00:06:39.520135Z","steps":["trace[2085452279] 'agreement among raft nodes before linearized reading' (duration: 196.012272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.533901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.418961ms","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-19T00:06:39.534141Z","caller":"traceutil/trace.go:171","msg":"trace[621841227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:477; }","duration":"183.704497ms","start":"2026-05-19T00:06:39.350416Z","end":"2026-05-19T00:06:39.534121Z","steps":["trace[621841227] 'agreement among raft nodes before linearized reading' (duration: 182.607903ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.535324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.737622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T00:06:39.535408Z","caller":"traceutil/trace.go:171","msg":"trace[708792051] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:477; }","duration":"193.821263ms","start":"2026-05-19T00:06:39.341568Z","end":"2026-05-19T00:06:39.53539Z","steps":["trace[708792051] 'agreement among raft nodes before linearized reading' (duration: 191.398289ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.913853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.722003ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:06:39.913932Z","caller":"traceutil/trace.go:171","msg":"trace[1677791377] linearizableReadLoop","detail":"{readStateIndex:513; appliedIndex:512; }","duration":"330.734044ms","start":"2026-05-19T00:06:39.583186Z","end":"2026-05-19T00:06:39.91392Z","steps":["trace[1677791377] 'read index received' (duration: 12.897938ms)","trace[1677791377] 'applied index is now lower than readState.Index' (duration: 317.835346ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:39.914031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.837337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-05-19T00:06:39.914052Z","caller":"traceutil/trace.go:171","msg":"trace[470470894] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:490; }","duration":"330.872627ms","start":"2026-05-19T00:06:39.583171Z","end":"2026-05-19T00:06:39.914044Z","steps":["trace[470470894] 'agreement among raft nodes before linearized reading' (duration: 330.808676ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.91402Z","caller":"traceutil/trace.go:171","msg":"trace[969045448] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"331.983632ms","start":"2026-05-19T00:06:39.581983Z","end":"2026-05-19T00:06:39.913967Z","steps":["trace[969045448] 'process raft request' (duration: 14.092475ms)","trace[969045448] 'compare' (duration: 317.596991ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:39.914095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.583167Z","time spent":"330.922579ms","remote":"127.0.0.1:44452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1036,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha3.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-05-19T00:06:39.914209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.581974Z","time spent":"332.136556ms","remote":"127.0.0.1:43908","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-19T00:06:39.916319Z","caller":"traceutil/trace.go:171","msg":"trace[1902966795] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"328.270549ms","start":"2026-05-19T00:06:39.588036Z","end":"2026-05-19T00:06:39.916307Z","steps":["trace[1902966795] 'process raft request' (duration: 328.116496ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.916392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.588012Z","time spent":"328.33833ms","remote":"127.0.0.1:43908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:39.916506Z","caller":"traceutil/trace.go:171","msg":"trace[707855362] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"321.931718ms","start":"2026-05-19T00:06:39.594565Z","end":"2026-05-19T00:06:39.916496Z","steps":["trace[707855362] 'process raft request' (duration: 321.696222ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.916552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.594545Z","time spent":"321.978848ms","remote":"127.0.0.1:43908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:39.930099Z","caller":"traceutil/trace.go:171","msg":"trace[33705161] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"334.072109ms","start":"2026-05-19T00:06:39.596004Z","end":"2026-05-19T00:06:39.930076Z","steps":["trace[33705161] 'process raft request' (duration: 333.814374ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.930231Z","caller":"traceutil/trace.go:171","msg":"trace[56529772] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"331.469221ms","start":"2026-05-19T00:06:39.598692Z","end":"2026-05-19T00:06:39.930161Z","steps":["trace[56529772] 'process raft request' (duration: 331.286347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.930326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.595995Z","time spent":"334.236753ms","remote":"127.0.0.1:43908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:06:39.930428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.598673Z","time spent":"331.646385ms","remote":"127.0.0.1:43908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:39.930429Z","caller":"traceutil/trace.go:171","msg":"trace[644247138] transaction","detail":"{read_only:false; number_of_response:1; response_revision:495; }","duration":"330.365556ms","start":"2026-05-19T00:06:39.600044Z","end":"2026-05-19T00:06:39.930409Z","steps":["trace[644247138] 'process raft request' (duration: 330.071049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.930565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.600038Z","time spent":"330.452558ms","remote":"127.0.0.1:43908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7733,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:39.930623Z","caller":"traceutil/trace.go:171","msg":"trace[1669641443] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"331.493791ms","start":"2026-05-19T00:06:39.599114Z","end":"2026-05-19T00:06:39.930608Z","steps":["trace[1669641443] 'process raft request' (duration: 330.939649ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.930695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.477239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:1013"} {"level":"info","ts":"2026-05-19T00:06:39.930711Z","caller":"traceutil/trace.go:171","msg":"trace[1291241450] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"293.557283ms","start":"2026-05-19T00:06:39.637141Z","end":"2026-05-19T00:06:39.930698Z","steps":["trace[1291241450] 'process raft request' (duration: 293.036542ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:39.930724Z","caller":"traceutil/trace.go:171","msg":"trace[1223662169] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:496; }","duration":"347.51372ms","start":"2026-05-19T00:06:39.583202Z","end":"2026-05-19T00:06:39.930715Z","steps":["trace[1223662169] 'agreement among raft nodes before linearized reading' (duration: 347.441078ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:39.930716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.599108Z","time spent":"331.552032ms","remote":"127.0.0.1:43908","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:06:39.930779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:39.583199Z","time spent":"347.54748ms","remote":"127.0.0.1:44452","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1036,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/v1alpha2.gateway.networking.k8s.io\" "} {"level":"warn","ts":"2026-05-19T00:06:39.930832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.161058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:39.930866Z","caller":"traceutil/trace.go:171","msg":"trace[1235567777] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:496; }","duration":"214.22228ms","start":"2026-05-19T00:06:39.716633Z","end":"2026-05-19T00:06:39.930855Z","steps":["trace[1235567777] 'agreement among raft nodes before linearized reading' (duration: 214.164219ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:43.799434Z","caller":"traceutil/trace.go:171","msg":"trace[2041957634] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"137.402383ms","start":"2026-05-19T00:06:43.661996Z","end":"2026-05-19T00:06:43.799398Z","steps":["trace[2041957634] 'process raft request' (duration: 136.975243ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:44.590915Z","caller":"traceutil/trace.go:171","msg":"trace[309071989] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"319.264787ms","start":"2026-05-19T00:06:44.271618Z","end":"2026-05-19T00:06:44.590883Z","steps":["trace[309071989] 'process raft request' (duration: 317.881276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:44.591057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:44.271584Z","time spent":"319.39977ms","remote":"127.0.0.1:43948","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036189,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:45.729478Z","caller":"traceutil/trace.go:171","msg":"trace[1918657942] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:592; }","duration":"149.521903ms","start":"2026-05-19T00:06:45.579918Z","end":"2026-05-19T00:06:45.729439Z","steps":["trace[1918657942] 'read index received' (duration: 148.95923ms)","trace[1918657942] 'applied index is now lower than readState.Index' (duration: 561.693µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:45.729578Z","caller":"traceutil/trace.go:171","msg":"trace[320257486] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"183.307538ms","start":"2026-05-19T00:06:45.5462Z","end":"2026-05-19T00:06:45.729508Z","steps":["trace[320257486] 'process raft request' (duration: 182.723175ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:45.729678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.744707ms","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-05-19T00:06:45.730431Z","caller":"traceutil/trace.go:171","msg":"trace[1983449528] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:568; }","duration":"150.559947ms","start":"2026-05-19T00:06:45.579852Z","end":"2026-05-19T00:06:45.730412Z","steps":["trace[1983449528] 'agreement among raft nodes before linearized reading' (duration: 149.757539ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:46.043143Z","caller":"traceutil/trace.go:171","msg":"trace[1516082514] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:593; }","duration":"313.530929ms","start":"2026-05-19T00:06:45.729585Z","end":"2026-05-19T00:06:46.043116Z","steps":["trace[1516082514] 'read index received' (duration: 313.321175ms)","trace[1516082514] 'applied index is now lower than readState.Index' (duration: 208.794µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:46.043263Z","caller":"traceutil/trace.go:171","msg":"trace[1723962463] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"330.56918ms","start":"2026-05-19T00:06:45.712628Z","end":"2026-05-19T00:06:46.043197Z","steps":["trace[1723962463] 'process raft request' (duration: 330.286994ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:46.043444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:45.712601Z","time spent":"330.737254ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:06:46.043454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.812737ms","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-19T00:06:46.043516Z","caller":"traceutil/trace.go:171","msg":"trace[653229229] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:569; }","duration":"459.046853ms","start":"2026-05-19T00:06:45.584449Z","end":"2026-05-19T00:06:46.043496Z","steps":["trace[653229229] 'agreement among raft nodes before linearized reading' (duration: 458.777247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:46.043319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.845935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:46.043579Z","caller":"traceutil/trace.go:171","msg":"trace[1268375045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:569; }","duration":"326.154351ms","start":"2026-05-19T00:06:45.717404Z","end":"2026-05-19T00:06:46.043559Z","steps":["trace[1268375045] 'agreement among raft nodes before linearized reading' (duration: 325.807053ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:46.043578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:45.58443Z","time spent":"459.131954ms","remote":"127.0.0.1:44148","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-19T00:06:46.043627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:45.717362Z","time spent":"326.253893ms","remote":"127.0.0.1:43870","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-19T00:06:46.043685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.823601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T00:06:46.043762Z","caller":"traceutil/trace.go:171","msg":"trace[434613118] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:569; }","duration":"455.947273ms","start":"2026-05-19T00:06:45.587801Z","end":"2026-05-19T00:06:46.043748Z","steps":["trace[434613118] 'agreement among raft nodes before linearized reading' (duration: 455.548064ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:46.043801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:45.587781Z","time spent":"456.008924ms","remote":"127.0.0.1:44148","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-05-19T00:06:46.117165Z","caller":"traceutil/trace.go:171","msg":"trace[1180736067] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"382.188404ms","start":"2026-05-19T00:06:45.734945Z","end":"2026-05-19T00:06:46.117133Z","steps":["trace[1180736067] 'process raft request' (duration: 381.964069ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:46.117221Z","caller":"traceutil/trace.go:171","msg":"trace[2045166830] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"314.39405ms","start":"2026-05-19T00:06:45.802806Z","end":"2026-05-19T00:06:46.1172Z","steps":["trace[2045166830] 'process raft request' (duration: 314.210016ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:46.117345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:45.802768Z","time spent":"314.502122ms","remote":"127.0.0.1:44238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-19T00:06:46.117375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:45.734912Z","time spent":"382.336108ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:06:48.716457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.00029173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-19T00:06:48.716552Z","caller":"traceutil/trace.go:171","msg":"trace[347625549] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000463924s","start":"2026-05-19T00:06:46.71607Z","end":"2026-05-19T00:06:48.716533Z","steps":["trace[347625549] 'agreement among raft nodes before linearized reading' (duration: 2.000348711s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.7166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.716048Z","time spent":"2.000543846s","remote":"127.0.0.1:43884","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-05-19T00:06:48.955412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:48.275046Z","time spent":"680.359512ms","remote":"127.0.0.1:51006","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-05-19T00:06:48.956105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.782836406s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:06:48.956237Z","caller":"traceutil/trace.go:171","msg":"trace[635990896] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"2.9086994s","start":"2026-05-19T00:06:46.047516Z","end":"2026-05-19T00:06:48.956216Z","steps":["trace[635990896] 'process raft request' (duration: 125.679ms)","trace[635990896] 'compare' (duration: 2.781933655s)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:48.956321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.047493Z","time spent":"2.908786252s","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:48.956502Z","caller":"traceutil/trace.go:171","msg":"trace[609412797] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"2.908066196s","start":"2026-05-19T00:06:46.048425Z","end":"2026-05-19T00:06:48.956492Z","steps":["trace[609412797] 'process raft request' (duration: 2.907734429s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:48.956564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.048415Z","time spent":"2.908116227s","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:48.957022Z","caller":"traceutil/trace.go:171","msg":"trace[940462531] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:594; }","duration":"2.890951194s","start":"2026-05-19T00:06:46.066057Z","end":"2026-05-19T00:06:48.957008Z","steps":["trace[940462531] 'read index received' (duration: 50.850487ms)","trace[940462531] 'applied index is now lower than readState.Index' (duration: 2.840099247s)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:49.034544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.905228313s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:49.034606Z","caller":"traceutil/trace.go:171","msg":"trace[647715307] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:573; }","duration":"2.905299734s","start":"2026-05-19T00:06:46.129292Z","end":"2026-05-19T00:06:49.034592Z","steps":["trace[647715307] 'agreement among raft nodes before linearized reading' (duration: 2.905203802s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:49.034643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.12923Z","time spent":"2.905404877s","remote":"127.0.0.1:44428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-05-19T00:06:49.034716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.968641551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j5w4p\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-19T00:06:49.034781Z","caller":"traceutil/trace.go:171","msg":"trace[2111537467] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j5w4p; range_end:; response_count:1; response_revision:573; }","duration":"2.968754363s","start":"2026-05-19T00:06:46.066012Z","end":"2026-05-19T00:06:49.034767Z","steps":["trace[2111537467] 'agreement among raft nodes before linearized reading' (duration: 2.891086537s)","trace[2111537467] 'range keys from in-memory index tree' (duration: 77.547154ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:49.034815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.065993Z","time spent":"2.968814584s","remote":"127.0.0.1:44052","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-j5w4p\" "} {"level":"warn","ts":"2026-05-19T00:06:49.034904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.335071575s","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-19T00:06:49.034908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"913.479695ms","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-05-19T00:06:49.035031Z","caller":"traceutil/trace.go:171","msg":"trace[553598379] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:573; }","duration":"2.335296071s","start":"2026-05-19T00:06:46.699704Z","end":"2026-05-19T00:06:49.035Z","steps":["trace[553598379] 'agreement among raft nodes before linearized reading' (duration: 2.334899582s)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:49.035063Z","caller":"traceutil/trace.go:171","msg":"trace[1171817734] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:573; }","duration":"913.663979ms","start":"2026-05-19T00:06:48.121367Z","end":"2026-05-19T00:06:49.035031Z","steps":["trace[1171817734] 'agreement among raft nodes before linearized reading' (duration: 913.192599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:49.035106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:46.699659Z","time spent":"2.335436914s","remote":"127.0.0.1:44148","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-19T00:06:49.035116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:48.121253Z","time spent":"913.851523ms","remote":"127.0.0.1:44148","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-05-19T00:06:49.036565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.77081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:49.036651Z","caller":"traceutil/trace.go:171","msg":"trace[352113625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"319.907333ms","start":"2026-05-19T00:06:48.716724Z","end":"2026-05-19T00:06:49.036632Z","steps":["trace[352113625] 'agreement among raft nodes before linearized reading' (duration: 319.712859ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:49.036695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:48.716705Z","time spent":"319.981965ms","remote":"127.0.0.1:43870","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-19T00:06:50.186824Z","caller":"traceutil/trace.go:171","msg":"trace[781699304] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"105.017478ms","start":"2026-05-19T00:06:50.081779Z","end":"2026-05-19T00:06:50.186797Z","steps":["trace[781699304] 'read index received' (duration: 104.182029ms)","trace[781699304] 'applied index is now lower than readState.Index' (duration: 834.129µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:50.186932Z","caller":"traceutil/trace.go:171","msg":"trace[912631819] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"249.992719ms","start":"2026-05-19T00:06:49.936911Z","end":"2026-05-19T00:06:50.186904Z","steps":["trace[912631819] 'process raft request' (duration: 249.294634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:50.187062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.240593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-j5w4p\" ","response":"range_response_count:1 size:17247"} {"level":"info","ts":"2026-05-19T00:06:50.187121Z","caller":"traceutil/trace.go:171","msg":"trace[1995560003] range","detail":"{range_begin:/registry/pods/kube-system/cilium-j5w4p; range_end:; response_count:1; response_revision:584; }","duration":"105.363856ms","start":"2026-05-19T00:06:50.08174Z","end":"2026-05-19T00:06:50.187104Z","steps":["trace[1995560003] 'agreement among raft nodes before linearized reading' (duration: 105.157771ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:50.251135Z","caller":"traceutil/trace.go:171","msg":"trace[344307883] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"168.16926ms","start":"2026-05-19T00:06:50.082943Z","end":"2026-05-19T00:06:50.251112Z","steps":["trace[344307883] 'process raft request' (duration: 168.065387ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:50.680677Z","caller":"traceutil/trace.go:171","msg":"trace[1937263331] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"477.857303ms","start":"2026-05-19T00:06:50.202795Z","end":"2026-05-19T00:06:50.680653Z","steps":["trace[1937263331] 'process raft request' (duration: 441.196953ms)","trace[1937263331] 'compare' (duration: 36.436625ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:50.68082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:50.202772Z","time spent":"477.971035ms","remote":"127.0.0.1:44052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:06:50.680805Z","caller":"traceutil/trace.go:171","msg":"trace[102893100] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"439.167728ms","start":"2026-05-19T00:06:50.24161Z","end":"2026-05-19T00:06:50.680777Z","steps":["trace[102893100] 'process raft request' (duration: 438.986103ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:50.680927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:06:50.24159Z","time spent":"439.27996ms","remote":"127.0.0.1:44118","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-19T00:06:50.947407Z","caller":"traceutil/trace.go:171","msg":"trace[1699404489] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"228.861407ms","start":"2026-05-19T00:06:50.718512Z","end":"2026-05-19T00:06:50.947374Z","steps":["trace[1699404489] 'read index received' (duration: 224.888398ms)","trace[1699404489] 'applied index is now lower than readState.Index' (duration: 3.971689ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:50.947527Z","caller":"traceutil/trace.go:171","msg":"trace[1588417303] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"244.981747ms","start":"2026-05-19T00:06:50.702516Z","end":"2026-05-19T00:06:50.947497Z","steps":["trace[1588417303] 'process raft request' (duration: 240.946957ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:50.947725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.467818ms","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-19T00:06:50.947812Z","caller":"traceutil/trace.go:171","msg":"trace[206847695] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:588; }","duration":"211.577ms","start":"2026-05-19T00:06:50.736221Z","end":"2026-05-19T00:06:50.947798Z","steps":["trace[206847695] 'agreement among raft nodes before linearized reading' (duration: 211.438867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:50.948204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.384736ms","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-19T00:06:50.948283Z","caller":"traceutil/trace.go:171","msg":"trace[304687583] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:588; }","duration":"211.474578ms","start":"2026-05-19T00:06:50.736797Z","end":"2026-05-19T00:06:50.948272Z","steps":["trace[304687583] 'agreement among raft nodes before linearized reading' (duration: 211.378376ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:50.947619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.086062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:50.948456Z","caller":"traceutil/trace.go:171","msg":"trace[991345180] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:588; }","duration":"229.971672ms","start":"2026-05-19T00:06:50.718469Z","end":"2026-05-19T00:06:50.94844Z","steps":["trace[991345180] 'agreement among raft nodes before linearized reading' (duration: 229.044431ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:50.948619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.339847ms","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-19T00:06:50.948655Z","caller":"traceutil/trace.go:171","msg":"trace[1286745056] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:588; }","duration":"212.407369ms","start":"2026-05-19T00:06:50.736237Z","end":"2026-05-19T00:06:50.948644Z","steps":["trace[1286745056] 'agreement among raft nodes before linearized reading' (duration: 212.323527ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.10883Z","caller":"traceutil/trace.go:171","msg":"trace[102887325] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"154.449463ms","start":"2026-05-19T00:06:50.95435Z","end":"2026-05-19T00:06:51.108799Z","steps":["trace[102887325] 'process raft request' (duration: 154.144006ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.108884Z","caller":"traceutil/trace.go:171","msg":"trace[869714581] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:614; }","duration":"146.861693ms","start":"2026-05-19T00:06:50.96199Z","end":"2026-05-19T00:06:51.108852Z","steps":["trace[869714581] 'read index received' (duration: 4.93498ms)","trace[869714581] 'applied index is now lower than readState.Index' (duration: 141.925043ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:51.10922Z","caller":"traceutil/trace.go:171","msg":"trace[1604211406] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"154.577826ms","start":"2026-05-19T00:06:50.954629Z","end":"2026-05-19T00:06:51.109207Z","steps":["trace[1604211406] 'process raft request' (duration: 154.062775ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.109355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.340424ms","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-19T00:06:51.109437Z","caller":"traceutil/trace.go:171","msg":"trace[910231723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"147.426926ms","start":"2026-05-19T00:06:50.961964Z","end":"2026-05-19T00:06:51.109391Z","steps":["trace[910231723] 'agreement among raft nodes before linearized reading' (duration: 147.252212ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.109519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.450447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T00:06:51.10956Z","caller":"traceutil/trace.go:171","msg":"trace[1763296855] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"147.512138ms","start":"2026-05-19T00:06:50.962038Z","end":"2026-05-19T00:06:51.10955Z","steps":["trace[1763296855] 'agreement among raft nodes before linearized reading' (duration: 147.367974ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.109803Z","caller":"traceutil/trace.go:171","msg":"trace[670829344] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"154.187047ms","start":"2026-05-19T00:06:50.95559Z","end":"2026-05-19T00:06:51.109777Z","steps":["trace[670829344] 'process raft request' (duration: 153.166924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.110022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.319004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:51.110069Z","caller":"traceutil/trace.go:171","msg":"trace[653776519] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:592; }","duration":"143.376066ms","start":"2026-05-19T00:06:50.96668Z","end":"2026-05-19T00:06:51.110056Z","steps":["trace[653776519] 'agreement among raft nodes before linearized reading' (duration: 143.255153ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.110049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.359705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:51.110228Z","caller":"traceutil/trace.go:171","msg":"trace[543161335] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:592; }","duration":"143.557969ms","start":"2026-05-19T00:06:50.966654Z","end":"2026-05-19T00:06:51.110211Z","steps":["trace[543161335] 'agreement among raft nodes before linearized reading' (duration: 143.315694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.110298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.980149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T00:06:51.110336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.936946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:51.11035Z","caller":"traceutil/trace.go:171","msg":"trace[1640833405] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:592; }","duration":"127.05907ms","start":"2026-05-19T00:06:50.983278Z","end":"2026-05-19T00:06:51.110337Z","steps":["trace[1640833405] 'agreement among raft nodes before linearized reading' (duration: 126.971038ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.110372Z","caller":"traceutil/trace.go:171","msg":"trace[1851980985] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:592; }","duration":"142.994257ms","start":"2026-05-19T00:06:50.967368Z","end":"2026-05-19T00:06:51.110362Z","steps":["trace[1851980985] 'agreement among raft nodes before linearized reading' (duration: 142.947736ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.110292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.269942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:51.110505Z","caller":"traceutil/trace.go:171","msg":"trace[1538009872] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:592; }","duration":"126.519529ms","start":"2026-05-19T00:06:50.983976Z","end":"2026-05-19T00:06:51.110496Z","steps":["trace[1538009872] 'agreement among raft nodes before linearized reading' (duration: 126.262223ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.110509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.04062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:51.110542Z","caller":"traceutil/trace.go:171","msg":"trace[1672988693] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:592; }","duration":"127.081471ms","start":"2026-05-19T00:06:50.983449Z","end":"2026-05-19T00:06:51.11053Z","steps":["trace[1672988693] 'agreement among raft nodes before linearized reading' (duration: 127.03513ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.280816Z","caller":"traceutil/trace.go:171","msg":"trace[35105533] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"163.962626ms","start":"2026-05-19T00:06:51.116829Z","end":"2026-05-19T00:06:51.280792Z","steps":["trace[35105533] 'process raft request' (duration: 163.794892ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.280799Z","caller":"traceutil/trace.go:171","msg":"trace[918532660] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:618; }","duration":"158.161295ms","start":"2026-05-19T00:06:51.122598Z","end":"2026-05-19T00:06:51.280759Z","steps":["trace[918532660] 'read index received' (duration: 110.348867ms)","trace[918532660] 'applied index is now lower than readState.Index' (duration: 47.811138ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:06:51.281073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.31961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:51.281132Z","caller":"traceutil/trace.go:171","msg":"trace[459363049] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:596; }","duration":"158.555075ms","start":"2026-05-19T00:06:51.122564Z","end":"2026-05-19T00:06:51.281119Z","steps":["trace[459363049] 'agreement among raft nodes before linearized reading' (duration: 158.292569ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.281141Z","caller":"traceutil/trace.go:171","msg":"trace[1771286681] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"164.427497ms","start":"2026-05-19T00:06:51.116695Z","end":"2026-05-19T00:06:51.281123Z","steps":["trace[1771286681] 'process raft request' (duration: 116.125027ms)","trace[1771286681] 'compare' (duration: 47.655835ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:06:51.281199Z","caller":"traceutil/trace.go:171","msg":"trace[236152423] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"163.24731ms","start":"2026-05-19T00:06:51.117893Z","end":"2026-05-19T00:06:51.281141Z","steps":["trace[236152423] 'process raft request' (duration: 162.78115ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:06:51.281383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.695388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:06:51.281411Z","caller":"traceutil/trace.go:171","msg":"trace[1610286510] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:596; }","duration":"158.78769ms","start":"2026-05-19T00:06:51.122616Z","end":"2026-05-19T00:06:51.281404Z","steps":["trace[1610286510] 'agreement among raft nodes before linearized reading' (duration: 158.694198ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:06:51.281379Z","caller":"traceutil/trace.go:171","msg":"trace[170254932] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"163.446374ms","start":"2026-05-19T00:06:51.117922Z","end":"2026-05-19T00:06:51.281368Z","steps":["trace[170254932] 'process raft request' (duration: 162.790779ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:05.73372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.927795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T00:07:05.734105Z","caller":"traceutil/trace.go:171","msg":"trace[2028967652] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:738; }","duration":"342.374845ms","start":"2026-05-19T00:07:05.391708Z","end":"2026-05-19T00:07:05.734083Z","steps":["trace[2028967652] 'range keys from in-memory index tree' (duration: 341.74137ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:05.734293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:05.39166Z","time spent":"342.62141ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T00:07:05.734137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.784285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jwsvl\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-05-19T00:07:05.734456Z","caller":"traceutil/trace.go:171","msg":"trace[1850061989] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jwsvl; range_end:; response_count:1; response_revision:738; }","duration":"564.113152ms","start":"2026-05-19T00:07:05.170292Z","end":"2026-05-19T00:07:05.734405Z","steps":["trace[1850061989] 'range keys from in-memory index tree' (duration: 563.58445ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:05.733989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.445976ms","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-05-19T00:07:05.734547Z","caller":"traceutil/trace.go:171","msg":"trace[350969605] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:738; }","duration":"334.025528ms","start":"2026-05-19T00:07:05.400506Z","end":"2026-05-19T00:07:05.734531Z","steps":["trace[350969605] 'range keys from in-memory index tree' (duration: 333.339072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:05.734571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:05.170269Z","time spent":"564.262036ms","remote":"127.0.0.1:44052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-jwsvl\" "} {"level":"warn","ts":"2026-05-19T00:07:05.734603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:05.400493Z","time spent":"334.095729ms","remote":"127.0.0.1:44148","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-05-19T00:07:05.734032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.146568ms","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-19T00:07:05.734695Z","caller":"traceutil/trace.go:171","msg":"trace[1595374440] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:738; }","duration":"354.816923ms","start":"2026-05-19T00:07:05.379834Z","end":"2026-05-19T00:07:05.734651Z","steps":["trace[1595374440] 'range keys from in-memory index tree' (duration: 354.009135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:05.734766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:05.379796Z","time spent":"354.952426ms","remote":"127.0.0.1:44148","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-19T00:07:05.733913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.772431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:07:05.73487Z","caller":"traceutil/trace.go:171","msg":"trace[547340181] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:738; }","duration":"503.765213ms","start":"2026-05-19T00:07:05.231093Z","end":"2026-05-19T00:07:05.734858Z","steps":["trace[547340181] 'range keys from in-memory index tree' (duration: 502.664308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:05.73493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:05.231056Z","time spent":"503.857394ms","remote":"127.0.0.1:43884","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-19T00:07:05.734137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.321617ms","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-19T00:07:05.735076Z","caller":"traceutil/trace.go:171","msg":"trace[2126051652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:738; }","duration":"268.316649ms","start":"2026-05-19T00:07:05.466743Z","end":"2026-05-19T00:07:05.73506Z","steps":["trace[2126051652] 'range keys from in-memory index tree' (duration: 267.099062ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:05.845054Z","caller":"traceutil/trace.go:171","msg":"trace[359620948] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"105.885346ms","start":"2026-05-19T00:07:05.739133Z","end":"2026-05-19T00:07:05.845018Z","steps":["trace[359620948] 'process raft request' (duration: 105.648231ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:05.856558Z","caller":"traceutil/trace.go:171","msg":"trace[121150712] transaction","detail":"{read_only:false; response_revision:741; number_of_response:1; }","duration":"116.603526ms","start":"2026-05-19T00:07:05.739894Z","end":"2026-05-19T00:07:05.856497Z","steps":["trace[121150712] 'process raft request' (duration: 116.388731ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:05.856485Z","caller":"traceutil/trace.go:171","msg":"trace[97273992] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"117.004775ms","start":"2026-05-19T00:07:05.739417Z","end":"2026-05-19T00:07:05.856421Z","steps":["trace[97273992] 'process raft request' (duration: 116.667618ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:05.856699Z","caller":"traceutil/trace.go:171","msg":"trace[1283965122] transaction","detail":"{read_only:false; response_revision:742; number_of_response:1; }","duration":"116.024273ms","start":"2026-05-19T00:07:05.740665Z","end":"2026-05-19T00:07:05.856689Z","steps":["trace[1283965122] 'process raft request' (duration: 115.695996ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:05.85676Z","caller":"traceutil/trace.go:171","msg":"trace[54774141] transaction","detail":"{read_only:false; response_revision:743; number_of_response:1; }","duration":"114.233533ms","start":"2026-05-19T00:07:05.742479Z","end":"2026-05-19T00:07:05.856712Z","steps":["trace[54774141] 'process raft request' (duration: 113.961817ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:34.628508Z","caller":"traceutil/trace.go:171","msg":"trace[1099895785] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"242.321788ms","start":"2026-05-19T00:07:34.386163Z","end":"2026-05-19T00:07:34.628485Z","steps":["trace[1099895785] 'process raft request' (duration: 242.159524ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:40.602083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367768453829098,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T00:07:40.878569Z","caller":"traceutil/trace.go:171","msg":"trace[701530859] linearizableReadLoop","detail":"{readStateIndex:990; appliedIndex:989; }","duration":"777.275182ms","start":"2026-05-19T00:07:40.101267Z","end":"2026-05-19T00:07:40.878543Z","steps":["trace[701530859] 'read index received' (duration: 777.087947ms)","trace[701530859] 'applied index is now lower than readState.Index' (duration: 186.005µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:07:40.878723Z","caller":"traceutil/trace.go:171","msg":"trace[185605810] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"805.299609ms","start":"2026-05-19T00:07:40.073411Z","end":"2026-05-19T00:07:40.878711Z","steps":["trace[185605810] 'process raft request' (duration: 804.92086ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:40.878861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.073382Z","time spent":"805.37639ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:07:40.878971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.685922ms","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-19T00:07:40.879073Z","caller":"traceutil/trace.go:171","msg":"trace[1350974535] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:950; }","duration":"777.827626ms","start":"2026-05-19T00:07:40.101219Z","end":"2026-05-19T00:07:40.879047Z","steps":["trace[1350974535] 'agreement among raft nodes before linearized reading' (duration: 777.58109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:40.87914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.101205Z","time spent":"777.920748ms","remote":"127.0.0.1:44148","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-19T00:07:41.577098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"536.699585ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:07:41.577269Z","caller":"traceutil/trace.go:171","msg":"trace[3811429] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"930.563896ms","start":"2026-05-19T00:07:40.646681Z","end":"2026-05-19T00:07:41.577245Z","steps":["trace[3811429] 'process raft request' (duration: 393.610255ms)","trace[3811429] 'compare' (duration: 536.203803ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:07:41.57731Z","caller":"traceutil/trace.go:171","msg":"trace[980832436] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"695.009867ms","start":"2026-05-19T00:07:40.882283Z","end":"2026-05-19T00:07:41.577293Z","steps":["trace[980832436] 'process raft request' (duration: 694.921845ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:41.577393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.882267Z","time spent":"695.078329ms","remote":"127.0.0.1:44148","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-19T00:07:41.577401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.64666Z","time spent":"930.663798ms","remote":"127.0.0.1:44148","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-05-19T00:07:41.577424Z","caller":"traceutil/trace.go:171","msg":"trace[841561462] linearizableReadLoop","detail":"{readStateIndex:991; appliedIndex:990; }","duration":"698.731246ms","start":"2026-05-19T00:07:40.878639Z","end":"2026-05-19T00:07:41.57737Z","steps":["trace[841561462] 'read index received' (duration: 161.664542ms)","trace[841561462] 'applied index is now lower than readState.Index' (duration: 537.063334ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:07:41.577654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.36206457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-19T00:07:41.577671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.431622443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-19T00:07:41.577688Z","caller":"traceutil/trace.go:171","msg":"trace[1374101339] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:952; }","duration":"1.362113031s","start":"2026-05-19T00:07:40.215565Z","end":"2026-05-19T00:07:41.577678Z","steps":["trace[1374101339] 'agreement among raft nodes before linearized reading' (duration: 1.361992468s)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:07:41.577707Z","caller":"traceutil/trace.go:171","msg":"trace[1639075596] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:952; }","duration":"1.431710776s","start":"2026-05-19T00:07:40.145984Z","end":"2026-05-19T00:07:41.577695Z","steps":["trace[1639075596] 'agreement among raft nodes before linearized reading' (duration: 1.431505811s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:41.577719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.215557Z","time spent":"1.362156402s","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T00:07:41.577743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.145965Z","time spent":"1.431770377s","remote":"127.0.0.1:44148","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-19T00:07:41.577795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.0523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:07:41.577817Z","caller":"traceutil/trace.go:171","msg":"trace[584748393] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"860.109131ms","start":"2026-05-19T00:07:40.7177Z","end":"2026-05-19T00:07:41.577809Z","steps":["trace[584748393] 'agreement among raft nodes before linearized reading' (duration: 860.07491ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:41.577835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.717679Z","time spent":"860.152642ms","remote":"127.0.0.1:43884","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-19T00:07:41.577882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.362446679s","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-05-19T00:07:41.577909Z","caller":"traceutil/trace.go:171","msg":"trace[523005914] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:952; }","duration":"1.36250496s","start":"2026-05-19T00:07:40.215393Z","end":"2026-05-19T00:07:41.577898Z","steps":["trace[523005914] 'agreement among raft nodes before linearized reading' (duration: 1.362433819s)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:41.577933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:40.215365Z","time spent":"1.362562052s","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T00:07:41.908782Z","caller":"traceutil/trace.go:171","msg":"trace[1200236862] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"326.853758ms","start":"2026-05-19T00:07:41.581886Z","end":"2026-05-19T00:07:41.90874Z","steps":["trace[1200236862] 'process raft request' (duration: 247.098713ms)","trace[1200236862] 'compare' (duration: 79.484469ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:07:41.908933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:41.581875Z","time spent":"326.979691ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:07:41.917192Z","caller":"traceutil/trace.go:171","msg":"trace[1986199331] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"335.144054ms","start":"2026-05-19T00:07:41.582029Z","end":"2026-05-19T00:07:41.917173Z","steps":["trace[1986199331] 'process raft request' (duration: 335.019342ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:41.917333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:41.582021Z","time spent":"335.232566ms","remote":"127.0.0.1:44148","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-19T00:07:41.917339Z","caller":"traceutil/trace.go:171","msg":"trace[1711158761] transaction","detail":"{read_only:false; response_revision:955; number_of_response:1; }","duration":"334.840028ms","start":"2026-05-19T00:07:41.582467Z","end":"2026-05-19T00:07:41.917307Z","steps":["trace[1711158761] 'process raft request' (duration: 334.682044ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:07:41.917508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:07:41.582461Z","time spent":"334.95356ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:07:46.055113Z","caller":"traceutil/trace.go:171","msg":"trace[726340528] transaction","detail":"{read_only:false; response_revision:967; number_of_response:1; }","duration":"107.041484ms","start":"2026-05-19T00:07:45.948045Z","end":"2026-05-19T00:07:46.055087Z","steps":["trace[726340528] 'process raft request' (duration: 106.815109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:04.619289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.251327ms","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-05-19T00:08:04.619392Z","caller":"traceutil/trace.go:171","msg":"trace[477915051] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1025; }","duration":"383.409751ms","start":"2026-05-19T00:08:04.235957Z","end":"2026-05-19T00:08:04.619367Z","steps":["trace[477915051] 'range keys from in-memory index tree' (duration: 383.001081ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:04.619454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:04.235937Z","time spent":"383.501373ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T00:08:04.619525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.53871ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-19T00:08:04.619614Z","caller":"traceutil/trace.go:171","msg":"trace[43023728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1025; }","duration":"382.684374ms","start":"2026-05-19T00:08:04.23691Z","end":"2026-05-19T00:08:04.619594Z","steps":["trace[43023728] 'range keys from in-memory index tree' (duration: 382.375406ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:04.619614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.216332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-19T00:08:04.619673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:04.236899Z","time spent":"382.763225ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T00:08:04.619678Z","caller":"traceutil/trace.go:171","msg":"trace[444660051] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1025; }","duration":"403.324164ms","start":"2026-05-19T00:08:04.216339Z","end":"2026-05-19T00:08:04.619663Z","steps":["trace[444660051] 'range keys from in-memory index tree' (duration: 403.018487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:04.619724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:04.216318Z","time spent":"403.393805ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-19T00:08:04.619621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.047932ms","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-19T00:08:04.619295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.661508ms","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-19T00:08:04.619848Z","caller":"traceutil/trace.go:171","msg":"trace[1901052282] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1025; }","duration":"489.271867ms","start":"2026-05-19T00:08:04.130557Z","end":"2026-05-19T00:08:04.619829Z","steps":["trace[1901052282] 'count revisions from in-memory index tree' (duration: 488.901488ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:04.619862Z","caller":"traceutil/trace.go:171","msg":"trace[380422683] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1025; }","duration":"488.246682ms","start":"2026-05-19T00:08:04.13159Z","end":"2026-05-19T00:08:04.619837Z","steps":["trace[380422683] 'range keys from in-memory index tree' (duration: 487.639748ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:04.619917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:04.130496Z","time spent":"489.39213ms","remote":"127.0.0.1:51152","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-19T00:08:04.620629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.018863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:04.620712Z","caller":"traceutil/trace.go:171","msg":"trace[1285958260] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1025; }","duration":"341.987417ms","start":"2026-05-19T00:08:04.27871Z","end":"2026-05-19T00:08:04.620697Z","steps":["trace[1285958260] 'count revisions from in-memory index tree' (duration: 340.669165ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:04.620802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:04.278695Z","time spent":"342.044928ms","remote":"127.0.0.1:51060","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"info","ts":"2026-05-19T00:08:04.647175Z","caller":"traceutil/trace.go:171","msg":"trace[471869273] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"157.289866ms","start":"2026-05-19T00:08:04.489859Z","end":"2026-05-19T00:08:04.647149Z","steps":["trace[471869273] 'process raft request' (duration: 157.145403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:06.349175Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367768453829314,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T00:08:06.513825Z","caller":"traceutil/trace.go:171","msg":"trace[174167196] linearizableReadLoop","detail":"{readStateIndex:1076; appliedIndex:1075; }","duration":"665.529067ms","start":"2026-05-19T00:08:05.84827Z","end":"2026-05-19T00:08:06.513799Z","steps":["trace[174167196] 'read index received' (duration: 665.321192ms)","trace[174167196] 'applied index is now lower than readState.Index' (duration: 206.935µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:06.513921Z","caller":"traceutil/trace.go:171","msg":"trace[475449234] transaction","detail":"{read_only:false; response_revision:1031; number_of_response:1; }","duration":"778.40473ms","start":"2026-05-19T00:08:05.735498Z","end":"2026-05-19T00:08:06.513903Z","steps":["trace[475449234] 'process raft request' (duration: 778.100902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:06.51405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:05.735475Z","time spent":"778.494631ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:08:06.514104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"665.829764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T00:08:06.514152Z","caller":"traceutil/trace.go:171","msg":"trace[5025708] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1031; }","duration":"665.883085ms","start":"2026-05-19T00:08:05.848256Z","end":"2026-05-19T00:08:06.514139Z","steps":["trace[5025708] 'agreement among raft nodes before linearized reading' (duration: 665.67464ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:06.514267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:05.848193Z","time spent":"666.060249ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T00:08:06.51435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.230024ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:06.514504Z","caller":"traceutil/trace.go:171","msg":"trace[701258152] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1031; }","duration":"459.49258ms","start":"2026-05-19T00:08:06.054983Z","end":"2026-05-19T00:08:06.514476Z","steps":["trace[701258152] 'agreement among raft nodes before linearized reading' (duration: 459.128492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:06.514575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:06.054954Z","time spent":"459.600813ms","remote":"127.0.0.1:44368","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-05-19T00:08:07.147568Z","caller":"traceutil/trace.go:171","msg":"trace[1213332952] transaction","detail":"{read_only:false; response_revision:1036; number_of_response:1; }","duration":"106.47349ms","start":"2026-05-19T00:08:07.041062Z","end":"2026-05-19T00:08:07.147536Z","steps":["trace[1213332952] 'process raft request' (duration: 106.256365ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:07.901532Z","caller":"traceutil/trace.go:171","msg":"trace[322539773] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"128.979405ms","start":"2026-05-19T00:08:07.772525Z","end":"2026-05-19T00:08:07.901504Z","steps":["trace[322539773] 'process raft request' (duration: 128.784841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:08.26381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.549898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:08.263899Z","caller":"traceutil/trace.go:171","msg":"trace[77133598] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1037; }","duration":"275.702821ms","start":"2026-05-19T00:08:07.988169Z","end":"2026-05-19T00:08:08.263872Z","steps":["trace[77133598] 'count revisions from in-memory index tree' (duration: 275.432435ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.197959Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334367768453829534,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-19T00:08:21.375792Z","caller":"traceutil/trace.go:171","msg":"trace[1150780884] linearizableReadLoop","detail":"{readStateIndex:1178; appliedIndex:1177; }","duration":"678.233696ms","start":"2026-05-19T00:08:20.697538Z","end":"2026-05-19T00:08:21.375772Z","steps":["trace[1150780884] 'read index received' (duration: 677.661852ms)","trace[1150780884] 'applied index is now lower than readState.Index' (duration: 571.214µs)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:21.375883Z","caller":"traceutil/trace.go:171","msg":"trace[49581951] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"816.336603ms","start":"2026-05-19T00:08:20.55954Z","end":"2026-05-19T00:08:21.375877Z","steps":["trace[49581951] 'process raft request' (duration: 815.607726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.375968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:20.559516Z","time spent":"816.388515ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:08:21.37612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"427.627959ms","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-19T00:08:21.37614Z","caller":"traceutil/trace.go:171","msg":"trace[1850564438] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1128; }","duration":"427.646849ms","start":"2026-05-19T00:08:20.948486Z","end":"2026-05-19T00:08:21.376133Z","steps":["trace[1850564438] 'agreement among raft nodes before linearized reading' (duration: 427.571627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.376134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.767659ms","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-19T00:08:21.37616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:20.948433Z","time spent":"427.724061ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-19T00:08:21.376174Z","caller":"traceutil/trace.go:171","msg":"trace[744405780] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1128; }","duration":"153.855151ms","start":"2026-05-19T00:08:21.222307Z","end":"2026-05-19T00:08:21.376162Z","steps":["trace[744405780] 'agreement among raft nodes before linearized reading' (duration: 153.758159ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.376184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"660.206069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:21.376272Z","caller":"traceutil/trace.go:171","msg":"trace[977786072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1128; }","duration":"660.344102ms","start":"2026-05-19T00:08:20.7159Z","end":"2026-05-19T00:08:21.376244Z","steps":["trace[977786072] 'agreement among raft nodes before linearized reading' (duration: 660.133277ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.376323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:20.715878Z","time spent":"660.435923ms","remote":"127.0.0.1:43884","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-19T00:08:21.376424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.367816ms","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-19T00:08:21.376481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.937082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-19T00:08:21.376508Z","caller":"traceutil/trace.go:171","msg":"trace[361669274] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1128; }","duration":"589.462419ms","start":"2026-05-19T00:08:20.787023Z","end":"2026-05-19T00:08:21.376486Z","steps":["trace[361669274] 'agreement among raft nodes before linearized reading' (duration: 589.213143ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:21.376519Z","caller":"traceutil/trace.go:171","msg":"trace[1211579170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1128; }","duration":"679.017064ms","start":"2026-05-19T00:08:20.697492Z","end":"2026-05-19T00:08:21.376509Z","steps":["trace[1211579170] 'agreement among raft nodes before linearized reading' (duration: 678.763898ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.376552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:20.697464Z","time spent":"679.081486ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-19T00:08:21.376555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:20.786969Z","time spent":"589.575862ms","remote":"127.0.0.1:44148","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-19T00:08:21.376136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.624094ms","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-19T00:08:21.376751Z","caller":"traceutil/trace.go:171","msg":"trace[1671903420] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1128; }","duration":"416.26917ms","start":"2026-05-19T00:08:20.960469Z","end":"2026-05-19T00:08:21.376738Z","steps":["trace[1671903420] 'agreement among raft nodes before linearized reading' (duration: 415.573143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.376784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:20.960451Z","time spent":"416.32306ms","remote":"127.0.0.1:44148","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-19T00:08:21.967535Z","caller":"traceutil/trace.go:171","msg":"trace[402726322] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"587.115023ms","start":"2026-05-19T00:08:21.380402Z","end":"2026-05-19T00:08:21.967517Z","steps":["trace[402726322] 'process raft request' (duration: 585.973216ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.967637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:21.380383Z","time spent":"587.198166ms","remote":"127.0.0.1:44148","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-19T00:08:21.973599Z","caller":"traceutil/trace.go:171","msg":"trace[248896431] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1178; }","duration":"297.035419ms","start":"2026-05-19T00:08:21.676549Z","end":"2026-05-19T00:08:21.973584Z","steps":["trace[248896431] 'read index received' (duration: 289.837518ms)","trace[248896431] 'applied index is now lower than readState.Index' (duration: 7.197171ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:21.973807Z","caller":"traceutil/trace.go:171","msg":"trace[1106539042] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"593.31902ms","start":"2026-05-19T00:08:21.38048Z","end":"2026-05-19T00:08:21.973799Z","steps":["trace[1106539042] 'process raft request' (duration: 592.954642ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.973873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:21.380462Z","time spent":"593.363902ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:08:21.97399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.120012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:21.974006Z","caller":"traceutil/trace.go:171","msg":"trace[174783542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1133; }","duration":"257.175493ms","start":"2026-05-19T00:08:21.716826Z","end":"2026-05-19T00:08:21.974002Z","steps":["trace[174783542] 'agreement among raft nodes before linearized reading' (duration: 257.147592ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:21.974048Z","caller":"traceutil/trace.go:171","msg":"trace[1197249462] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"593.446054ms","start":"2026-05-19T00:08:21.380589Z","end":"2026-05-19T00:08:21.974035Z","steps":["trace[1197249462] 'process raft request' (duration: 592.931302ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.974092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:21.380583Z","time spent":"593.486185ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:08:21.974062Z","caller":"traceutil/trace.go:171","msg":"trace[1623489118] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"593.009524ms","start":"2026-05-19T00:08:21.381018Z","end":"2026-05-19T00:08:21.974027Z","steps":["trace[1623489118] 'process raft request' (duration: 592.526822ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:21.974248Z","caller":"traceutil/trace.go:171","msg":"trace[1555689414] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"593.099805ms","start":"2026-05-19T00:08:21.381127Z","end":"2026-05-19T00:08:21.974227Z","steps":["trace[1555689414] 'process raft request' (duration: 592.43476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:21.97427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:21.38101Z","time spent":"593.132646ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-19T00:08:21.974354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:21.381101Z","time spent":"593.192158ms","remote":"127.0.0.1:44148","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-05-19T00:08:21.974309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.616473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-19T00:08:21.974424Z","caller":"traceutil/trace.go:171","msg":"trace[1621828561] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1133; }","duration":"297.889449ms","start":"2026-05-19T00:08:21.676507Z","end":"2026-05-19T00:08:21.974396Z","steps":["trace[1621828561] 'agreement among raft nodes before linearized reading' (duration: 297.47426ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:32.160473Z","caller":"traceutil/trace.go:171","msg":"trace[634991408] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"143.911056ms","start":"2026-05-19T00:08:32.016535Z","end":"2026-05-19T00:08:32.160446Z","steps":["trace[634991408] 'process raft request' (duration: 143.852884ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:32.160607Z","caller":"traceutil/trace.go:171","msg":"trace[231992911] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"144.95736ms","start":"2026-05-19T00:08:32.015606Z","end":"2026-05-19T00:08:32.160563Z","steps":["trace[231992911] 'process raft request' (duration: 63.532148ms)","trace[231992911] 'compare' (duration: 81.029903ms)"],"step_count":2} {"level":"info","ts":"2026-05-19T00:08:32.18783Z","caller":"traceutil/trace.go:171","msg":"trace[282159236] transaction","detail":"{read_only:false; response_revision:1166; number_of_response:1; }","duration":"139.281455ms","start":"2026-05-19T00:08:32.048534Z","end":"2026-05-19T00:08:32.187815Z","steps":["trace[282159236] 'process raft request' (duration: 139.200063ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:36.767364Z","caller":"traceutil/trace.go:171","msg":"trace[1945586367] transaction","detail":"{read_only:false; response_revision:1195; number_of_response:1; }","duration":"255.264167ms","start":"2026-05-19T00:08:36.512083Z","end":"2026-05-19T00:08:36.767347Z","steps":["trace[1945586367] 'process raft request' (duration: 254.816497ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:37.28255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.004042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-05-19T00:08:37.282664Z","caller":"traceutil/trace.go:171","msg":"trace[1915447557] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1198; }","duration":"153.178285ms","start":"2026-05-19T00:08:37.129459Z","end":"2026-05-19T00:08:37.282638Z","steps":["trace[1915447557] 'range keys from in-memory index tree' (duration: 152.417668ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:37.634398Z","caller":"traceutil/trace.go:171","msg":"trace[467482669] transaction","detail":"{read_only:false; response_revision:1199; number_of_response:1; }","duration":"344.566687ms","start":"2026-05-19T00:08:37.289801Z","end":"2026-05-19T00:08:37.634368Z","steps":["trace[467482669] 'process raft request' (duration: 344.406293ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:37.634546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:37.289772Z","time spent":"344.696351ms","remote":"127.0.0.1:44040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5457,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-19T00:08:37.646359Z","caller":"traceutil/trace.go:171","msg":"trace[2129545755] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"211.256074ms","start":"2026-05-19T00:08:37.435081Z","end":"2026-05-19T00:08:37.646337Z","steps":["trace[2129545755] 'process raft request' (duration: 211.020848ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:38.558306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.838923ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-19T00:08:38.558544Z","caller":"traceutil/trace.go:171","msg":"trace[34636772] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"294.659913ms","start":"2026-05-19T00:08:38.263817Z","end":"2026-05-19T00:08:38.558477Z","steps":["trace[34636772] 'process raft request' (duration: 27.567674ms)","trace[34636772] 'compare' (duration: 266.576047ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:08:39.12262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.21011ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-19T00:08:39.122743Z","caller":"traceutil/trace.go:171","msg":"trace[1151938090] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1261; }","duration":"423.429649ms","start":"2026-05-19T00:08:38.699294Z","end":"2026-05-19T00:08:39.122724Z","steps":["trace[1151938090] 'read index received' (duration: 36.231µs)","trace[1151938090] 'applied index is now lower than readState.Index' (duration: 423.391678ms)"],"step_count":2} {"level":"warn","ts":"2026-05-19T00:08:39.122975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.645554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-19T00:08:39.123082Z","caller":"traceutil/trace.go:171","msg":"trace[408425853] range","detail":"{range_begin:/registry/cilium.io/ciliumcidrgroups/; range_end:/registry/cilium.io/ciliumcidrgroups0; response_count:0; response_revision:1208; }","duration":"423.799358ms","start":"2026-05-19T00:08:38.699263Z","end":"2026-05-19T00:08:39.123062Z","steps":["trace[408425853] 'agreement among raft nodes before linearized reading' (duration: 423.617334ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:39.123002Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.112878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-19T00:08:39.123139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:38.699229Z","time spent":"423.89674ms","remote":"127.0.0.1:37668","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumcidrgroups/\" range_end:\"/registry/cilium.io/ciliumcidrgroups0\" count_only:true "} {"level":"info","ts":"2026-05-19T00:08:39.123197Z","caller":"traceutil/trace.go:171","msg":"trace[582501553] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1208; }","duration":"406.328993ms","start":"2026-05-19T00:08:38.716838Z","end":"2026-05-19T00:08:39.123167Z","steps":["trace[582501553] 'agreement among raft nodes before linearized reading' (duration: 406.097738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:39.123246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:38.716823Z","time spent":"406.413685ms","remote":"127.0.0.1:43884","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-19T00:08:40.555675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.868546ms","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-05-19T00:08:40.555716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.718335ms","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-05-19T00:08:40.555759Z","caller":"traceutil/trace.go:171","msg":"trace[2096821531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1216; }","duration":"326.969229ms","start":"2026-05-19T00:08:40.22877Z","end":"2026-05-19T00:08:40.55574Z","steps":["trace[2096821531] 'range keys from in-memory index tree' (duration: 326.694743ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:40.555771Z","caller":"traceutil/trace.go:171","msg":"trace[1567686803] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1216; }","duration":"305.834697ms","start":"2026-05-19T00:08:40.249923Z","end":"2026-05-19T00:08:40.555758Z","steps":["trace[1567686803] 'range keys from in-memory index tree' (duration: 305.54262ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:40.555801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:40.249898Z","time spent":"305.896649ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-19T00:08:40.555815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:40.228735Z","time spent":"327.064051ms","remote":"127.0.0.1:44148","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-19T00:08:40.555792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.261194ms","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-19T00:08:40.555675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.037838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-19T00:08:40.555951Z","caller":"traceutil/trace.go:171","msg":"trace[1104205793] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1216; }","duration":"289.361017ms","start":"2026-05-19T00:08:40.26658Z","end":"2026-05-19T00:08:40.555941Z","steps":["trace[1104205793] 'range keys from in-memory index tree' (duration: 288.872264ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:40.555956Z","caller":"traceutil/trace.go:171","msg":"trace[899798424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1216; }","duration":"364.451499ms","start":"2026-05-19T00:08:40.191453Z","end":"2026-05-19T00:08:40.555905Z","steps":["trace[899798424] 'range keys from in-memory index tree' (duration: 364.009948ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:40.556006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-19T00:08:40.191435Z","time spent":"364.561231ms","remote":"127.0.0.1:44148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-19T00:08:45.744236Z","caller":"traceutil/trace.go:171","msg":"trace[1269348687] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"125.678303ms","start":"2026-05-19T00:08:45.618529Z","end":"2026-05-19T00:08:45.744207Z","steps":["trace[1269348687] 'process raft request' (duration: 125.513739ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:46.291956Z","caller":"traceutil/trace.go:171","msg":"trace[2122583535] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"115.121142ms","start":"2026-05-19T00:08:46.176813Z","end":"2026-05-19T00:08:46.291934Z","steps":["trace[2122583535] 'process raft request' (duration: 114.910887ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:51.89407Z","caller":"traceutil/trace.go:171","msg":"trace[1688924005] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"128.016649ms","start":"2026-05-19T00:08:51.766028Z","end":"2026-05-19T00:08:51.894045Z","steps":["trace[1688924005] 'process raft request' (duration: 127.843815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:52.489502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.009113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-19T00:08:52.489661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.023094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-05-19T00:08:52.489719Z","caller":"traceutil/trace.go:171","msg":"trace[518808921] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1296; }","duration":"167.121306ms","start":"2026-05-19T00:08:52.322582Z","end":"2026-05-19T00:08:52.489703Z","steps":["trace[518808921] 'range keys from in-memory index tree' (duration: 166.84493ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:08:52.489666Z","caller":"traceutil/trace.go:171","msg":"trace[477884854] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1296; }","duration":"191.242489ms","start":"2026-05-19T00:08:52.298403Z","end":"2026-05-19T00:08:52.489645Z","steps":["trace[477884854] 'count revisions from in-memory index tree' (duration: 190.89203ms)"],"step_count":1} {"level":"warn","ts":"2026-05-19T00:08:52.489912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.135173ms","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-05-19T00:08:52.49003Z","caller":"traceutil/trace.go:171","msg":"trace[759623494] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1296; }","duration":"174.271626ms","start":"2026-05-19T00:08:52.315733Z","end":"2026-05-19T00:08:52.490005Z","steps":["trace[759623494] 'range keys from in-memory index tree' (duration: 173.952259ms)"],"step_count":1} {"level":"info","ts":"2026-05-19T00:11:26.731437Z","caller":"traceutil/trace.go:171","msg":"trace[123828349] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"108.548144ms","start":"2026-05-19T00:11:26.622849Z","end":"2026-05-19T00:11:26.731397Z","steps":["trace[123828349] 'process raft request' (duration: 108.253047ms)"],"step_count":1}