{"level":"warn","ts":"2026-07-28T14:12:17.296793Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-28T14:12:17.297034Z","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-07-28T14:12:17.298416Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-28T14:12:17.29902Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-07-28T14:12:17.299053Z","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-07-28T14:12:17.302311Z","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-07-28T14:12:17.302487Z","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-07-28T14:12:17.306909Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.072038ms"} {"level":"info","ts":"2026-07-28T14:12:17.312071Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-07-28T14:12:17.312252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-07-28T14:12:17.312353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-07-28T14:12:17.312423Z","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-07-28T14:12:17.312508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-07-28T14:12:17.312606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-07-28T14:12:17.317441Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-28T14:12:17.319034Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-28T14:12:17.321407Z","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-07-28T14:12:17.324355Z","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-07-28T14:12:17.324562Z","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-07-28T14:12:17.324652Z","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-07-28T14:12:17.324662Z","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-07-28T14:12:17.324575Z","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-07-28T14:12:17.332743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-07-28T14:12:17.333035Z","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-07-28T14:12:17.33719Z","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-07-28T14:12:17.337286Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-07-28T14:12:17.337349Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-07-28T14:12:17.337458Z","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-07-28T14:12:17.337504Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-28T14:12:17.713005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-07-28T14:12:17.713067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-07-28T14:12:17.713096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-07-28T14:12:17.713127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-07-28T14:12:17.713149Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-07-28T14:12:17.713175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-07-28T14:12:17.713194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-07-28T14:12:17.714Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T14:12:17.714835Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T14:12:17.714831Z","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-07-28T14:12:17.714857Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-28T14:12:17.715047Z","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-07-28T14:12:17.715171Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T14:12:17.71518Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-28T14:12:17.715214Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-28T14:12:17.71522Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-28T14:12:17.716952Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"info","ts":"2026-07-28T14:12:17.717393Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-28T14:12:42.828341Z","caller":"traceutil/trace.go:171","msg":"trace[1827888567] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"149.175491ms","start":"2026-07-28T14:12:42.679131Z","end":"2026-07-28T14:12:42.828306Z","steps":["trace[1827888567] 'process raft request' (duration: 149.018377ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:13:00.912263Z","caller":"traceutil/trace.go:171","msg":"trace[1186732445] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:619; }","duration":"298.330553ms","start":"2026-07-28T14:13:00.613904Z","end":"2026-07-28T14:13:00.912235Z","steps":["trace[1186732445] 'read index received' (duration: 297.300764ms)","trace[1186732445] 'applied index is now lower than readState.Index' (duration: 1.028879ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:13:00.912419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.502707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.109\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-28T14:13:00.9125Z","caller":"traceutil/trace.go:171","msg":"trace[925611372] range","detail":"{range_begin:/registry/masterleases/199.204.45.109; range_end:; response_count:1; response_revision:595; }","duration":"298.638602ms","start":"2026-07-28T14:13:00.613844Z","end":"2026-07-28T14:13:00.912482Z","steps":["trace[925611372] 'agreement among raft nodes before linearized reading' (duration: 298.496488ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:13:00.912688Z","caller":"traceutil/trace.go:171","msg":"trace[1108315910] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"362.70411ms","start":"2026-07-28T14:13:00.549975Z","end":"2026-07-28T14:13:00.912679Z","steps":["trace[1108315910] 'process raft request' (duration: 361.714713ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:13:00.913402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:13:00.549952Z","time spent":"362.759711ms","remote":"127.0.0.1:50482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T14:13:01.61781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"569.231293ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-28T14:13:01.618017Z","caller":"traceutil/trace.go:171","msg":"trace[1269348700] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"657.34792ms","start":"2026-07-28T14:13:00.960638Z","end":"2026-07-28T14:13:01.617986Z","steps":["trace[1269348700] 'process raft request' (duration: 87.608033ms)","trace[1269348700] 'compare' (duration: 567.655699ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:13:01.617921Z","caller":"traceutil/trace.go:171","msg":"trace[935767880] linearizableReadLoop","detail":"{readStateIndex:623; appliedIndex:622; }","duration":"272.706791ms","start":"2026-07-28T14:13:01.345199Z","end":"2026-07-28T14:13:01.617906Z","steps":["trace[935767880] 'read index received' (duration: 54.881µs)","trace[935767880] 'applied index is now lower than readState.Index' (duration: 272.65078ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:13:01.618151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:13:00.960614Z","time spent":"657.473523ms","remote":"127.0.0.1:50866","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-28T14:13:01.618403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.958037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T14:13:01.618636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.328549ms","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-07-28T14:13:01.61843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.220615ms","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-07-28T14:13:01.618799Z","caller":"traceutil/trace.go:171","msg":"trace[218271940] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:597; }","duration":"273.478113ms","start":"2026-07-28T14:13:01.345249Z","end":"2026-07-28T14:13:01.618727Z","steps":["trace[218271940] 'agreement among raft nodes before linearized reading' (duration: 273.115143ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:13:01.618838Z","caller":"traceutil/trace.go:171","msg":"trace[1011444212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:597; }","duration":"273.660268ms","start":"2026-07-28T14:13:01.345147Z","end":"2026-07-28T14:13:01.618807Z","steps":["trace[1011444212] 'agreement among raft nodes before linearized reading' (duration: 273.02131ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:13:01.618566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.640195ms","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-07-28T14:13:01.618957Z","caller":"traceutil/trace.go:171","msg":"trace[1086036726] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:597; }","duration":"172.091708ms","start":"2026-07-28T14:13:01.446852Z","end":"2026-07-28T14:13:01.618944Z","steps":["trace[1086036726] 'agreement among raft nodes before linearized reading' (duration: 171.534672ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:13:01.618695Z","caller":"traceutil/trace.go:171","msg":"trace[238008362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:597; }","duration":"135.279446ms","start":"2026-07-28T14:13:01.483392Z","end":"2026-07-28T14:13:01.618672Z","steps":["trace[238008362] 'agreement among raft nodes before linearized reading' (duration: 134.909716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:13:16.778425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.736302ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-28T14:13:16.778503Z","caller":"traceutil/trace.go:171","msg":"trace[1261844301] linearizableReadLoop","detail":"{readStateIndex:791; appliedIndex:790; }","duration":"292.653395ms","start":"2026-07-28T14:13:16.485837Z","end":"2026-07-28T14:13:16.77849Z","steps":["trace[1261844301] 'read index received' (duration: 46.807889ms)","trace[1261844301] 'applied index is now lower than readState.Index' (duration: 245.844676ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:13:16.778594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.750637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:13:16.77862Z","caller":"traceutil/trace.go:171","msg":"trace[1211996040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:761; }","duration":"292.821149ms","start":"2026-07-28T14:13:16.48579Z","end":"2026-07-28T14:13:16.778612Z","steps":["trace[1211996040] 'agreement among raft nodes before linearized reading' (duration: 292.769818ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:13:16.778848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.980796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2zwfv\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-28T14:13:16.778959Z","caller":"traceutil/trace.go:171","msg":"trace[533401878] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-2zwfv; range_end:; response_count:1; response_revision:761; }","duration":"252.13689ms","start":"2026-07-28T14:13:16.526794Z","end":"2026-07-28T14:13:16.778931Z","steps":["trace[533401878] 'agreement among raft nodes before linearized reading' (duration: 251.829632ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:13:51.27119Z","caller":"traceutil/trace.go:171","msg":"trace[1767296499] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"448.80528ms","start":"2026-07-28T14:13:50.822355Z","end":"2026-07-28T14:13:51.27116Z","steps":["trace[1767296499] 'process raft request' (duration: 448.609324ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:13:51.271336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:13:50.822336Z","time spent":"448.926063ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T14:13:51.575955Z","caller":"traceutil/trace.go:171","msg":"trace[1228229067] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"300.440817ms","start":"2026-07-28T14:13:51.275478Z","end":"2026-07-28T14:13:51.575918Z","steps":["trace[1228229067] 'process raft request' (duration: 245.267625ms)","trace[1228229067] 'compare' (duration: 54.902185ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:13:51.576157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:13:51.27545Z","time spent":"300.608582ms","remote":"127.0.0.1:50646","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-07-28T14:13:51.935483Z","caller":"traceutil/trace.go:171","msg":"trace[2078827498] linearizableReadLoop","detail":"{readStateIndex:1017; appliedIndex:1016; }","duration":"111.845436ms","start":"2026-07-28T14:13:51.823595Z","end":"2026-07-28T14:13:51.935441Z","steps":["trace[2078827498] 'read index received' (duration: 25.38449ms)","trace[2078827498] 'applied index is now lower than readState.Index' (duration: 86.459196ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:13:51.935501Z","caller":"traceutil/trace.go:171","msg":"trace[2087590490] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"254.278094ms","start":"2026-07-28T14:13:51.681181Z","end":"2026-07-28T14:13:51.93546Z","steps":["trace[2087590490] 'process raft request' (duration: 167.880071ms)","trace[2087590490] 'compare' (duration: 86.208888ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:13:51.935696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.084052ms","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-07-28T14:13:51.935779Z","caller":"traceutil/trace.go:171","msg":"trace[1445750559] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:979; }","duration":"112.202895ms","start":"2026-07-28T14:13:51.823551Z","end":"2026-07-28T14:13:51.935754Z","steps":["trace[1445750559] 'agreement among raft nodes before linearized reading' (duration: 112.02576ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:13:51.935776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.166564ms","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-07-28T14:13:51.935834Z","caller":"traceutil/trace.go:171","msg":"trace[1890065398] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:979; }","duration":"108.324718ms","start":"2026-07-28T14:13:51.827488Z","end":"2026-07-28T14:13:51.935812Z","steps":["trace[1890065398] 'agreement among raft nodes before linearized reading' (duration: 108.189484ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:11.842824Z","caller":"traceutil/trace.go:171","msg":"trace[130564455] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"189.211799ms","start":"2026-07-28T14:14:11.653585Z","end":"2026-07-28T14:14:11.842797Z","steps":["trace[130564455] 'process raft request' (duration: 189.052785ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:12.036666Z","caller":"traceutil/trace.go:171","msg":"trace[2035272583] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"307.660636ms","start":"2026-07-28T14:14:11.72897Z","end":"2026-07-28T14:14:12.036631Z","steps":["trace[2035272583] 'process raft request' (duration: 307.507042ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:12.036827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:11.728942Z","time spent":"307.79943ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T14:14:13.282346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.151653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-28T14:14:13.282416Z","caller":"traceutil/trace.go:171","msg":"trace[1276714850] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1049; }","duration":"249.273186ms","start":"2026-07-28T14:14:13.033126Z","end":"2026-07-28T14:14:13.282399Z","steps":["trace[1276714850] 'count revisions from in-memory index tree' (duration: 249.06918ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:13.282386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:12.830563Z","time spent":"451.813294ms","remote":"127.0.0.1:41216","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-28T14:14:14.356275Z","caller":"traceutil/trace.go:171","msg":"trace[323041551] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"506.235193ms","start":"2026-07-28T14:14:13.850014Z","end":"2026-07-28T14:14:14.356249Z","steps":["trace[323041551] 'process raft request' (duration: 506.063828ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:14.356436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:13.849993Z","time spent":"506.363257ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-28T14:14:14.472286Z","caller":"traceutil/trace.go:171","msg":"trace[1727905626] linearizableReadLoop","detail":"{readStateIndex:1093; appliedIndex:1091; }","duration":"417.382242ms","start":"2026-07-28T14:14:14.05488Z","end":"2026-07-28T14:14:14.472263Z","steps":["trace[1727905626] 'read index received' (duration: 301.346231ms)","trace[1727905626] 'applied index is now lower than readState.Index' (duration: 116.034931ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:14:14.472403Z","caller":"traceutil/trace.go:171","msg":"trace[572842219] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"425.689882ms","start":"2026-07-28T14:14:14.046677Z","end":"2026-07-28T14:14:14.472367Z","steps":["trace[572842219] 'process raft request' (duration: 371.24268ms)","trace[572842219] 'compare' (duration: 54.187845ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:14:14.472512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:14.046641Z","time spent":"425.814625ms","remote":"127.0.0.1:50646","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-07-28T14:14:14.472553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.65125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-28T14:14:14.472593Z","caller":"traceutil/trace.go:171","msg":"trace[1806985306] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1051; }","duration":"417.732412ms","start":"2026-07-28T14:14:14.054849Z","end":"2026-07-28T14:14:14.472582Z","steps":["trace[1806985306] 'agreement among raft nodes before linearized reading' (duration: 417.535436ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:14.472568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.864409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T14:14:14.472609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.540456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-28T14:14:14.472628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:14.05484Z","time spent":"417.780784ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-28T14:14:14.472647Z","caller":"traceutil/trace.go:171","msg":"trace[1681161252] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1051; }","duration":"229.992573ms","start":"2026-07-28T14:14:14.242633Z","end":"2026-07-28T14:14:14.472626Z","steps":["trace[1681161252] 'agreement among raft nodes before linearized reading' (duration: 229.861169ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:14.47266Z","caller":"traceutil/trace.go:171","msg":"trace[627305296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1051; }","duration":"409.606397ms","start":"2026-07-28T14:14:14.06304Z","end":"2026-07-28T14:14:14.472647Z","steps":["trace[627305296] 'agreement among raft nodes before linearized reading' (duration: 409.430733ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:14.472701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:14.063034Z","time spent":"409.655339ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-28T14:14:14.47277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.155085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:14:14.472808Z","caller":"traceutil/trace.go:171","msg":"trace[1829597729] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1051; }","duration":"326.225248ms","start":"2026-07-28T14:14:14.146573Z","end":"2026-07-28T14:14:14.472798Z","steps":["trace[1829597729] 'agreement among raft nodes before linearized reading' (duration: 326.161946ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:14.472839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:14.146556Z","time spent":"326.275018ms","remote":"127.0.0.1:45824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-28T14:14:14.472852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.564007ms","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-07-28T14:14:14.472882Z","caller":"traceutil/trace.go:171","msg":"trace[208198930] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1051; }","duration":"409.605178ms","start":"2026-07-28T14:14:14.063267Z","end":"2026-07-28T14:14:14.472872Z","steps":["trace[208198930] 'agreement among raft nodes before linearized reading' (duration: 409.519935ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:14.472909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:14.06326Z","time spent":"409.643188ms","remote":"127.0.0.1:50646","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-07-28T14:14:15.465754Z","caller":"traceutil/trace.go:171","msg":"trace[305262433] transaction","detail":"{read_only:false; response_revision:1056; number_of_response:1; }","duration":"144.548687ms","start":"2026-07-28T14:14:15.321179Z","end":"2026-07-28T14:14:15.465728Z","steps":["trace[305262433] 'process raft request' (duration: 144.356762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:15.603192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.191082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:14:15.603269Z","caller":"traceutil/trace.go:171","msg":"trace[864356225] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1056; }","duration":"117.326747ms","start":"2026-07-28T14:14:15.485924Z","end":"2026-07-28T14:14:15.603251Z","steps":["trace[864356225] 'range keys from in-memory index tree' (duration: 117.056689ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:46.612832Z","caller":"traceutil/trace.go:171","msg":"trace[709921924] linearizableReadLoop","detail":"{readStateIndex:1273; appliedIndex:1272; }","duration":"113.123582ms","start":"2026-07-28T14:14:46.499679Z","end":"2026-07-28T14:14:46.612803Z","steps":["trace[709921924] 'read index received' (duration: 99.946489ms)","trace[709921924] 'applied index is now lower than readState.Index' (duration: 13.175813ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:14:46.61285Z","caller":"traceutil/trace.go:171","msg":"trace[1050021631] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"123.276023ms","start":"2026-07-28T14:14:46.489545Z","end":"2026-07-28T14:14:46.612821Z","steps":["trace[1050021631] 'process raft request' (duration: 110.105569ms)","trace[1050021631] 'compare' (duration: 13.00848ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:14:46.612998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.311987ms","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-07-28T14:14:46.613052Z","caller":"traceutil/trace.go:171","msg":"trace[1016928885] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1222; }","duration":"113.3948ms","start":"2026-07-28T14:14:46.499644Z","end":"2026-07-28T14:14:46.613039Z","steps":["trace[1016928885] 'agreement among raft nodes before linearized reading' (duration: 113.253966ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:46.758207Z","caller":"traceutil/trace.go:171","msg":"trace[519368887] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"187.783555ms","start":"2026-07-28T14:14:46.570401Z","end":"2026-07-28T14:14:46.758185Z","steps":["trace[519368887] 'process raft request' (duration: 187.668302ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:46.760046Z","caller":"traceutil/trace.go:171","msg":"trace[1190501516] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"142.360481ms","start":"2026-07-28T14:14:46.617667Z","end":"2026-07-28T14:14:46.760027Z","steps":["trace[1190501516] 'process raft request' (duration: 142.065442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:46.76064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.114486ms","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-07-28T14:14:46.760701Z","caller":"traceutil/trace.go:171","msg":"trace[45414669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1224; }","duration":"133.206478ms","start":"2026-07-28T14:14:46.62748Z","end":"2026-07-28T14:14:46.760686Z","steps":["trace[45414669] 'agreement among raft nodes before linearized reading' (duration: 133.012983ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:46.76097Z","caller":"traceutil/trace.go:171","msg":"trace[1315383060] linearizableReadLoop","detail":"{readStateIndex:1275; appliedIndex:1274; }","duration":"132.346965ms","start":"2026-07-28T14:14:46.627504Z","end":"2026-07-28T14:14:46.759851Z","steps":["trace[1315383060] 'read index received' (duration: 131.187853ms)","trace[1315383060] 'applied index is now lower than readState.Index' (duration: 1.157952ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:14:46.761458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.010258ms","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-07-28T14:14:46.761471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.133047ms","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-07-28T14:14:46.761505Z","caller":"traceutil/trace.go:171","msg":"trace[414258355] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1224; }","duration":"131.075869ms","start":"2026-07-28T14:14:46.630418Z","end":"2026-07-28T14:14:46.761493Z","steps":["trace[414258355] 'agreement among raft nodes before linearized reading' (duration: 130.931455ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:46.761534Z","caller":"traceutil/trace.go:171","msg":"trace[1580106345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1224; }","duration":"133.220799ms","start":"2026-07-28T14:14:46.628288Z","end":"2026-07-28T14:14:46.761509Z","steps":["trace[1580106345] 'agreement among raft nodes before linearized reading' (duration: 133.072144ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:46.76165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.942729ms","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-07-28T14:14:46.761788Z","caller":"traceutil/trace.go:171","msg":"trace[508698787] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1224; }","duration":"134.211886ms","start":"2026-07-28T14:14:46.627546Z","end":"2026-07-28T14:14:46.761758Z","steps":["trace[508698787] 'agreement among raft nodes before linearized reading' (duration: 133.800555ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:48.962882Z","caller":"traceutil/trace.go:171","msg":"trace[532077483] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"147.635757ms","start":"2026-07-28T14:14:48.81522Z","end":"2026-07-28T14:14:48.962855Z","steps":["trace[532077483] 'process raft request' (duration: 139.553784ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:48.962952Z","caller":"traceutil/trace.go:171","msg":"trace[1935875943] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"147.080111ms","start":"2026-07-28T14:14:48.815856Z","end":"2026-07-28T14:14:48.962936Z","steps":["trace[1935875943] 'process raft request' (duration: 147.04098ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:48.963023Z","caller":"traceutil/trace.go:171","msg":"trace[1635708736] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"147.177934ms","start":"2026-07-28T14:14:48.815834Z","end":"2026-07-28T14:14:48.963012Z","steps":["trace[1635708736] 'process raft request' (duration: 147.02605ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:48.962951Z","caller":"traceutil/trace.go:171","msg":"trace[24165438] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"147.651097ms","start":"2026-07-28T14:14:48.815261Z","end":"2026-07-28T14:14:48.962912Z","steps":["trace[24165438] 'process raft request' (duration: 147.544434ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:49.697713Z","caller":"traceutil/trace.go:171","msg":"trace[878285170] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1290; }","duration":"153.042106ms","start":"2026-07-28T14:14:49.544653Z","end":"2026-07-28T14:14:49.697695Z","steps":["trace[878285170] 'read index received' (duration: 152.883582ms)","trace[878285170] 'applied index is now lower than readState.Index' (duration: 157.884µs)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:14:49.697877Z","caller":"traceutil/trace.go:171","msg":"trace[1500573753] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"225.101995ms","start":"2026-07-28T14:14:49.472639Z","end":"2026-07-28T14:14:49.697741Z","steps":["trace[1500573753] 'process raft request' (duration: 224.937751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:49.697955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.16803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:14:49.698011Z","caller":"traceutil/trace.go:171","msg":"trace[1701787104] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1240; }","duration":"153.404386ms","start":"2026-07-28T14:14:49.544597Z","end":"2026-07-28T14:14:49.698001Z","steps":["trace[1701787104] 'agreement among raft nodes before linearized reading' (duration: 153.16581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:50.210735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.468693ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-28T14:14:50.210829Z","caller":"traceutil/trace.go:171","msg":"trace[303702619] linearizableReadLoop","detail":"{readStateIndex:1292; appliedIndex:1291; }","duration":"106.86463ms","start":"2026-07-28T14:14:50.103948Z","end":"2026-07-28T14:14:50.210813Z","steps":["trace[303702619] 'read index received' (duration: 30.761µs)","trace[303702619] 'applied index is now lower than readState.Index' (duration: 106.832558ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:14:50.210921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.964012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-28T14:14:50.211162Z","caller":"traceutil/trace.go:171","msg":"trace[2117517706] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1241; }","duration":"107.23668ms","start":"2026-07-28T14:14:50.103914Z","end":"2026-07-28T14:14:50.21115Z","steps":["trace[2117517706] 'agreement among raft nodes before linearized reading' (duration: 106.944012ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:50.210961Z","caller":"traceutil/trace.go:171","msg":"trace[188908202] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"506.833374ms","start":"2026-07-28T14:14:49.704105Z","end":"2026-07-28T14:14:50.210939Z","steps":["trace[188908202] 'process raft request' (duration: 364.089504ms)","trace[188908202] 'compare' (duration: 142.230806ms)"],"step_count":2} {"level":"warn","ts":"2026-07-28T14:14:50.21147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:49.704078Z","time spent":"507.362769ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-28T14:14:51.051383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.694211ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-28T14:14:51.051693Z","caller":"traceutil/trace.go:171","msg":"trace[1415598927] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"349.681815ms","start":"2026-07-28T14:14:50.701972Z","end":"2026-07-28T14:14:51.051654Z","steps":["trace[1415598927] 'process raft request' (duration: 181.646945ms)","trace[1415598927] 'compare' (duration: 167.387413ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:14:51.051729Z","caller":"traceutil/trace.go:171","msg":"trace[671801458] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"235.927125ms","start":"2026-07-28T14:14:50.815771Z","end":"2026-07-28T14:14:51.051698Z","steps":["trace[671801458] 'process raft request' (duration: 235.712579ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:51.051785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:14:50.701937Z","time spent":"349.802009ms","remote":"127.0.0.1:50450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-28T14:14:51.051882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.350218ms","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-07-28T14:14:51.051941Z","caller":"traceutil/trace.go:171","msg":"trace[2142530339] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1247; }","duration":"210.449351ms","start":"2026-07-28T14:14:50.841483Z","end":"2026-07-28T14:14:51.051932Z","steps":["trace[2142530339] 'agreement among raft nodes before linearized reading' (duration: 210.287017ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:51.051563Z","caller":"traceutil/trace.go:171","msg":"trace[1427985652] linearizableReadLoop","detail":"{readStateIndex:1299; appliedIndex:1297; }","duration":"210.019589ms","start":"2026-07-28T14:14:50.841528Z","end":"2026-07-28T14:14:51.051547Z","steps":["trace[1427985652] 'read index received' (duration: 42.01266ms)","trace[1427985652] 'applied index is now lower than readState.Index' (duration: 168.006079ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:14:51.26846Z","caller":"traceutil/trace.go:171","msg":"trace[980043646] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"213.123904ms","start":"2026-07-28T14:14:51.055309Z","end":"2026-07-28T14:14:51.268433Z","steps":["trace[980043646] 'process raft request' (duration: 137.469415ms)","trace[980043646] 'compare' (duration: 75.539906ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:14:51.339597Z","caller":"traceutil/trace.go:171","msg":"trace[1709888045] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"282.797918ms","start":"2026-07-28T14:14:51.056759Z","end":"2026-07-28T14:14:51.339557Z","steps":["trace[1709888045] 'process raft request' (duration: 282.553311ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:51.339617Z","caller":"traceutil/trace.go:171","msg":"trace[965560184] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1299; }","duration":"281.211855ms","start":"2026-07-28T14:14:51.058375Z","end":"2026-07-28T14:14:51.339587Z","steps":["trace[965560184] 'read index received' (duration: 134.519705ms)","trace[965560184] 'applied index is now lower than readState.Index' (duration: 146.69081ms)"],"step_count":2} {"level":"info","ts":"2026-07-28T14:14:51.339713Z","caller":"traceutil/trace.go:171","msg":"trace[518295588] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"281.980036ms","start":"2026-07-28T14:14:51.057726Z","end":"2026-07-28T14:14:51.339706Z","steps":["trace[518295588] 'process raft request' (duration: 281.817292ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:51.3397Z","caller":"traceutil/trace.go:171","msg":"trace[1786499764] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"282.009606ms","start":"2026-07-28T14:14:51.057664Z","end":"2026-07-28T14:14:51.339673Z","steps":["trace[1786499764] 'process raft request' (duration: 281.845442ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:51.339815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.428021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-07-28T14:14:51.339849Z","caller":"traceutil/trace.go:171","msg":"trace[2125625080] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1252; }","duration":"281.493173ms","start":"2026-07-28T14:14:51.058345Z","end":"2026-07-28T14:14:51.339839Z","steps":["trace[2125625080] 'agreement among raft nodes before linearized reading' (duration: 281.409811ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:14:51.339639Z","caller":"traceutil/trace.go:171","msg":"trace[594682737] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"282.138691ms","start":"2026-07-28T14:14:51.05747Z","end":"2026-07-28T14:14:51.339608Z","steps":["trace[594682737] 'process raft request' (duration: 281.997727ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:14:51.339915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.267516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-28T14:14:51.339939Z","caller":"traceutil/trace.go:171","msg":"trace[85464172] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1252; }","duration":"105.346679ms","start":"2026-07-28T14:14:51.234586Z","end":"2026-07-28T14:14:51.339933Z","steps":["trace[85464172] 'agreement among raft nodes before linearized reading' (duration: 105.277307ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:15:01.195758Z","caller":"traceutil/trace.go:171","msg":"trace[248422910] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"116.448576ms","start":"2026-07-28T14:15:01.079282Z","end":"2026-07-28T14:15:01.19573Z","steps":["trace[248422910] 'process raft request' (duration: 116.198179ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:15:02.197779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.367046ms","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-07-28T14:15:02.197855Z","caller":"traceutil/trace.go:171","msg":"trace[500029846] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1321; }","duration":"810.506841ms","start":"2026-07-28T14:15:01.38733Z","end":"2026-07-28T14:15:02.197837Z","steps":["trace[500029846] 'range keys from in-memory index tree' (duration: 810.157421ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:15:02.198149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"886.096418ms","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-07-28T14:15:02.198166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.85193ms","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-07-28T14:15:02.198225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.741051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-28T14:15:02.198273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.242477ms","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-07-28T14:15:02.198298Z","caller":"traceutil/trace.go:171","msg":"trace[2092887231] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1321; }","duration":"817.271707ms","start":"2026-07-28T14:15:01.381019Z","end":"2026-07-28T14:15:02.198291Z","steps":["trace[2092887231] 'range keys from in-memory index tree' (duration: 817.118823ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:15:02.198238Z","caller":"traceutil/trace.go:171","msg":"trace[1402773638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1321; }","duration":"814.958903ms","start":"2026-07-28T14:15:01.383261Z","end":"2026-07-28T14:15:02.19822Z","steps":["trace[1402773638] 'range keys from in-memory index tree' (duration: 814.697966ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:15:02.198318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"813.358299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-28T14:15:02.198329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:15:01.380937Z","time spent":"817.38489ms","remote":"127.0.0.1:50646","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-07-28T14:15:02.198349Z","caller":"traceutil/trace.go:171","msg":"trace[1985292874] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1321; }","duration":"813.428251ms","start":"2026-07-28T14:15:01.384912Z","end":"2026-07-28T14:15:02.198341Z","steps":["trace[1985292874] 'range keys from in-memory index tree' (duration: 813.254297ms)"],"step_count":1} {"level":"info","ts":"2026-07-28T14:15:02.198194Z","caller":"traceutil/trace.go:171","msg":"trace[1067237708] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1321; }","duration":"886.160289ms","start":"2026-07-28T14:15:01.312022Z","end":"2026-07-28T14:15:02.198182Z","steps":["trace[1067237708] 'range keys from in-memory index tree' (duration: 885.992404ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:15:02.198388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:15:01.312008Z","time spent":"886.370795ms","remote":"127.0.0.1:50646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-28T14:15:02.198293Z","caller":"traceutil/trace.go:171","msg":"trace[663962665] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1321; }","duration":"180.868315ms","start":"2026-07-28T14:15:02.017406Z","end":"2026-07-28T14:15:02.198275Z","steps":["trace[663962665] 'count revisions from in-memory index tree' (duration: 180.657048ms)"],"step_count":1} {"level":"warn","ts":"2026-07-28T14:15:02.198346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:15:01.383251Z","time spent":"815.080076ms","remote":"127.0.0.1:50646","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-07-28T14:15:02.19839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:15:01.38489Z","time spent":"813.491183ms","remote":"127.0.0.1:50646","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-07-28T14:15:02.197897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-28T14:15:01.387317Z","time spent":"810.570912ms","remote":"127.0.0.1:50646","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\" "}