{"level":"warn","ts":"2026-04-28T13:50:10.723187Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:50:10.723314Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.22: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.22:2380","--initial-cluster=instance=https://199.204.45.22:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.22:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.22: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-04-28T13:50:10.723384Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-28T13:50:10.723398Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-28T13:50:10.723421Z","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-04-28T13:50:10.724084Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"]} {"level":"info","ts":"2026-04-28T13:50:10.724184Z","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.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.22: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-04-28T13:50:10.728463Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.047227ms"} {"level":"info","ts":"2026-04-28T13:50:10.734502Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fed19d9291630e09","cluster-id":"6ebf1e01320cc017"} {"level":"info","ts":"2026-04-28T13:50:10.734584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T13:50:10.734612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 0"} {"level":"info","ts":"2026-04-28T13:50:10.734627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fed19d9291630e09 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T13:50:10.734638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became follower at term 1"} {"level":"info","ts":"2026-04-28T13:50:10.734702Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"warn","ts":"2026-04-28T13:50:10.744456Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T13:50:10.746476Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T13:50:10.747609Z","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-04-28T13:50:10.752687Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fed19d9291630e09","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T13:50:10.755733Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fed19d9291630e09","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T13:50:10.757229Z","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-04-28T13:50:10.757344Z","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-04-28T13:50:10.757379Z","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-04-28T13:50:10.758326Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 switched to configuration voters=(18361630408596196873)"} {"level":"info","ts":"2026-04-28T13:50:10.758509Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","added-peer-id":"fed19d9291630e09","added-peer-peer-urls":["https://199.204.45.22:2380"]} {"level":"info","ts":"2026-04-28T13:50:10.758895Z","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-04-28T13:50:10.759173Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fed19d9291630e09","initial-advertise-peer-urls":["https://199.204.45.22:2380"],"listen-peer-urls":["https://199.204.45.22:2380"],"advertise-client-urls":["https://199.204.45.22:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.22:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T13:50:10.759207Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T13:50:10.759784Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-28T13:50:10.759817Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.22:2380"} {"level":"info","ts":"2026-04-28T13:50:11.335531Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T13:50:11.33561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T13:50:11.335689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgPreVoteResp from fed19d9291630e09 at term 1"} {"level":"info","ts":"2026-04-28T13:50:11.335722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became candidate at term 2"} {"level":"info","ts":"2026-04-28T13:50:11.335737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 received MsgVoteResp from fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-28T13:50:11.335761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fed19d9291630e09 became leader at term 2"} {"level":"info","ts":"2026-04-28T13:50:11.33579Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fed19d9291630e09 elected leader fed19d9291630e09 at term 2"} {"level":"info","ts":"2026-04-28T13:50:11.337759Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fed19d9291630e09","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.22:2379]}","request-path":"/0/members/fed19d9291630e09/attributes","cluster-id":"6ebf1e01320cc017","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T13:50:11.337766Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:11.337766Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:50:11.337839Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T13:50:11.33826Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T13:50:11.338302Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T13:50:11.33907Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"6ebf1e01320cc017","local-member-id":"fed19d9291630e09","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:11.339217Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:11.339262Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T13:50:11.340815Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.22:2379"} {"level":"info","ts":"2026-04-28T13:50:11.342584Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-28T13:50:15.887951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.561328001s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-28T13:50:15.888103Z","caller":"traceutil/trace.go:171","msg":"trace[2095784342] linearizableReadLoop","detail":"{readStateIndex:83; appliedIndex:82; }","duration":"1.239215029s","start":"2026-04-28T13:50:14.648867Z","end":"2026-04-28T13:50:15.888082Z","steps":["trace[2095784342] 'read index received' (duration: 43.731µs)","trace[2095784342] 'applied index is now lower than readState.Index' (duration: 1.239170018s)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:15.888266Z","caller":"traceutil/trace.go:171","msg":"trace[1749713724] transaction","detail":"{read_only:false; response_revision:79; number_of_response:1; }","duration":"2.081051916s","start":"2026-04-28T13:50:13.807084Z","end":"2026-04-28T13:50:15.888135Z","steps":["trace[1749713724] 'process raft request' (duration: 518.818928ms)","trace[1749713724] 'compare' (duration: 1.561034519s)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:15.888375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23948104s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T13:50:15.888472Z","caller":"traceutil/trace.go:171","msg":"trace[588660935] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:79; }","duration":"1.239656278s","start":"2026-04-28T13:50:14.648791Z","end":"2026-04-28T13:50:15.888447Z","steps":["trace[588660935] 'agreement among raft nodes before linearized reading' (duration: 1.239416508s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:15.888457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.580885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-28T13:50:15.888524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:14.64876Z","time spent":"1.239757142s","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T13:50:15.888557Z","caller":"traceutil/trace.go:171","msg":"trace[267149588] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:79; }","duration":"101.758833ms","start":"2026-04-28T13:50:15.78676Z","end":"2026-04-28T13:50:15.888519Z","steps":["trace[267149588] 'agreement among raft nodes before linearized reading' (duration: 101.592176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:15.888622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:13.807052Z","time spent":"2.08136869s","remote":"127.0.0.1:51774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":710,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:50:15.888642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"636.826254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-28T13:50:15.889197Z","caller":"traceutil/trace.go:171","msg":"trace[764066476] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:79; }","duration":"637.561144ms","start":"2026-04-28T13:50:15.251609Z","end":"2026-04-28T13:50:15.88917Z","steps":["trace[764066476] 'agreement among raft nodes before linearized reading' (duration: 636.731391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:15.889264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:15.251585Z","time spent":"637.666269ms","remote":"127.0.0.1:51590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"info","ts":"2026-04-28T13:50:16.648073Z","caller":"traceutil/trace.go:171","msg":"trace[983297040] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"755.448639ms","start":"2026-04-28T13:50:15.892586Z","end":"2026-04-28T13:50:16.648035Z","steps":["trace[983297040] 'process raft request' (duration: 755.121196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:16.648256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:15.892565Z","time spent":"755.597795ms","remote":"127.0.0.1:51634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:16.649899Z","caller":"traceutil/trace.go:171","msg":"trace[1668429172] transaction","detail":"{read_only:false; response_revision:81; number_of_response:1; }","duration":"754.941418ms","start":"2026-04-28T13:50:15.894927Z","end":"2026-04-28T13:50:16.649868Z","steps":["trace[1668429172] 'process raft request' (duration: 754.567192ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:16.649872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:16.106848Z","time spent":"543.019226ms","remote":"127.0.0.1:51526","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-28T13:50:16.65004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:15.894912Z","time spent":"755.058683ms","remote":"127.0.0.1:51774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":708,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T13:50:18.064679Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.047880676s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T13:50:18.077904Z","caller":"traceutil/trace.go:171","msg":"trace[2121806704] transaction","detail":"{read_only:false; response_revision:177; number_of_response:1; }","duration":"1.06118089s","start":"2026-04-28T13:50:17.016685Z","end":"2026-04-28T13:50:18.077866Z","steps":["trace[2121806704] 'process raft request' (duration: 1.048311072s)","trace[2121806704] 'compare' (duration: 12.104278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:18.078155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.006401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:18.078201Z","caller":"traceutil/trace.go:171","msg":"trace[2092899942] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:178; }","duration":"291.116735ms","start":"2026-04-28T13:50:17.787071Z","end":"2026-04-28T13:50:18.078188Z","steps":["trace[2092899942] 'agreement among raft nodes before linearized reading' (duration: 291.002251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:18.078225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:17.016661Z","time spent":"1.061495112s","remote":"127.0.0.1:51782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":682,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:18.077955Z","caller":"traceutil/trace.go:171","msg":"trace[514978126] transaction","detail":"{read_only:false; response_revision:178; number_of_response:1; }","duration":"180.133825ms","start":"2026-04-28T13:50:17.897784Z","end":"2026-04-28T13:50:18.077918Z","steps":["trace[514978126] 'process raft request' (duration: 180.039951ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:18.078051Z","caller":"traceutil/trace.go:171","msg":"trace[1358108483] linearizableReadLoop","detail":"{readStateIndex:182; appliedIndex:181; }","duration":"290.911257ms","start":"2026-04-28T13:50:17.787128Z","end":"2026-04-28T13:50:18.078039Z","steps":["trace[1358108483] 'read index received' (duration: 277.884864ms)","trace[1358108483] 'applied index is now lower than readState.Index' (duration: 13.025263ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:18.079492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.141299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:18.079589Z","caller":"traceutil/trace.go:171","msg":"trace[534058668] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:178; }","duration":"131.329036ms","start":"2026-04-28T13:50:17.948236Z","end":"2026-04-28T13:50:18.079565Z","steps":["trace[534058668] 'agreement among raft nodes before linearized reading' (duration: 131.133628ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:48.80192Z","caller":"traceutil/trace.go:171","msg":"trace[1535006037] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:537; }","duration":"223.752937ms","start":"2026-04-28T13:50:48.578128Z","end":"2026-04-28T13:50:48.80188Z","steps":["trace[1535006037] 'read index received' (duration: 223.451509ms)","trace[1535006037] 'applied index is now lower than readState.Index' (duration: 299.698µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:48.80211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.944332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:48.802207Z","caller":"traceutil/trace.go:171","msg":"trace[170326072] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:520; }","duration":"224.065775ms","start":"2026-04-28T13:50:48.578112Z","end":"2026-04-28T13:50:48.802178Z","steps":["trace[170326072] 'agreement among raft nodes before linearized reading' (duration: 223.901601ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:49.693467Z","caller":"traceutil/trace.go:171","msg":"trace[450087501] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"374.211951ms","start":"2026-04-28T13:50:49.319234Z","end":"2026-04-28T13:50:49.693446Z","steps":["trace[450087501] 'process raft request' (duration: 374.086818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.693782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.319212Z","time spent":"374.327744ms","remote":"127.0.0.1:51708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:50:49.708379Z","caller":"traceutil/trace.go:171","msg":"trace[760215924] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"121.455096ms","start":"2026-04-28T13:50:49.586899Z","end":"2026-04-28T13:50:49.708355Z","steps":["trace[760215924] 'process raft request' (duration: 120.749637ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:49.708566Z","caller":"traceutil/trace.go:171","msg":"trace[1997659768] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"320.530332ms","start":"2026-04-28T13:50:49.388016Z","end":"2026-04-28T13:50:49.708546Z","steps":["trace[1997659768] 'process raft request' (duration: 319.159685ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.708642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.388008Z","time spent":"320.574024ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:49.708718Z","caller":"traceutil/trace.go:171","msg":"trace[100964130] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"320.462061ms","start":"2026-04-28T13:50:49.388247Z","end":"2026-04-28T13:50:49.708709Z","steps":["trace[100964130] 'process raft request' (duration: 318.96641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.708756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.38824Z","time spent":"320.491281ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:49.708816Z","caller":"traceutil/trace.go:171","msg":"trace[2047752823] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"308.781057ms","start":"2026-04-28T13:50:49.400026Z","end":"2026-04-28T13:50:49.708807Z","steps":["trace[2047752823] 'process raft request' (duration: 307.222365ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.708874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.400004Z","time spent":"308.853819ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:49.708938Z","caller":"traceutil/trace.go:171","msg":"trace[286341905] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"293.997046ms","start":"2026-04-28T13:50:49.414925Z","end":"2026-04-28T13:50:49.708922Z","steps":["trace[286341905] 'process raft request' (duration: 292.391733ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:49.709156Z","caller":"traceutil/trace.go:171","msg":"trace[1539043566] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"286.250902ms","start":"2026-04-28T13:50:49.422747Z","end":"2026-04-28T13:50:49.708998Z","steps":["trace[1539043566] 'process raft request' (duration: 284.649169ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:49.709323Z","caller":"traceutil/trace.go:171","msg":"trace[382507231] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"264.415118ms","start":"2026-04-28T13:50:49.444818Z","end":"2026-04-28T13:50:49.709233Z","steps":["trace[382507231] 'process raft request' (duration: 262.663529ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:49.709524Z","caller":"traceutil/trace.go:171","msg":"trace[266661183] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"322.162378ms","start":"2026-04-28T13:50:49.387312Z","end":"2026-04-28T13:50:49.709475Z","steps":["trace[266661183] 'process raft request' (duration: 319.816653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.709563Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.387305Z","time spent":"322.23329ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:49.709773Z","caller":"traceutil/trace.go:171","msg":"trace[1524711420] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"336.99447ms","start":"2026-04-28T13:50:49.372713Z","end":"2026-04-28T13:50:49.709707Z","steps":["trace[1524711420] 'process raft request' (duration: 334.252104ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.709812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.37269Z","time spent":"337.103622ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:49.710047Z","caller":"traceutil/trace.go:171","msg":"trace[1146972058] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"337.227476ms","start":"2026-04-28T13:50:49.372673Z","end":"2026-04-28T13:50:49.7099Z","steps":["trace[1146972058] 'process raft request' (duration: 334.139761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.710084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.372663Z","time spent":"337.402241ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:49.710276Z","caller":"traceutil/trace.go:171","msg":"trace[548209899] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"337.498033ms","start":"2026-04-28T13:50:49.372728Z","end":"2026-04-28T13:50:49.710226Z","steps":["trace[548209899] 'process raft request' (duration: 334.323845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.710321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.372524Z","time spent":"337.772521ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:49.710551Z","caller":"traceutil/trace.go:171","msg":"trace[646600018] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"323.391912ms","start":"2026-04-28T13:50:49.387058Z","end":"2026-04-28T13:50:49.71045Z","steps":["trace[646600018] 'process raft request' (duration: 320.03762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:49.710589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:49.387034Z","time spent":"323.539355ms","remote":"127.0.0.1:51498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T13:50:53.861168Z","caller":"traceutil/trace.go:171","msg":"trace[1945181737] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"192.762183ms","start":"2026-04-28T13:50:53.668389Z","end":"2026-04-28T13:50:53.861152Z","steps":["trace[1945181737] 'process raft request' (duration: 192.677731ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:53.861429Z","caller":"traceutil/trace.go:171","msg":"trace[1840072439] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:636; }","duration":"164.589065ms","start":"2026-04-28T13:50:53.696733Z","end":"2026-04-28T13:50:53.861322Z","steps":["trace[1840072439] 'read index received' (duration: 164.567554ms)","trace[1840072439] 'applied index is now lower than readState.Index' (duration: 17.961µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:53.861835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.047317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:53.861881Z","caller":"traceutil/trace.go:171","msg":"trace[902812705] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:615; }","duration":"165.160559ms","start":"2026-04-28T13:50:53.696706Z","end":"2026-04-28T13:50:53.861867Z","steps":["trace[902812705] 'agreement among raft nodes before linearized reading' (duration: 164.921823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:53.875071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.253278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:53.87512Z","caller":"traceutil/trace.go:171","msg":"trace[577485491] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:615; }","duration":"178.34263ms","start":"2026-04-28T13:50:53.696768Z","end":"2026-04-28T13:50:53.87511Z","steps":["trace[577485491] 'agreement among raft nodes before linearized reading' (duration: 178.265348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:53.875472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.403655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:53.875516Z","caller":"traceutil/trace.go:171","msg":"trace[133813324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"116.485077ms","start":"2026-04-28T13:50:53.759015Z","end":"2026-04-28T13:50:53.8755Z","steps":["trace[133813324] 'agreement among raft nodes before linearized reading' (duration: 116.430985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:53.875824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.964635ms","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-04-28T13:50:53.875852Z","caller":"traceutil/trace.go:171","msg":"trace[190841903] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"118.017187ms","start":"2026-04-28T13:50:53.757829Z","end":"2026-04-28T13:50:53.875846Z","steps":["trace[190841903] 'agreement among raft nodes before linearized reading' (duration: 117.944805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:53.876054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.05659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:50:53.876083Z","caller":"traceutil/trace.go:171","msg":"trace[65111836] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"129.117171ms","start":"2026-04-28T13:50:53.74696Z","end":"2026-04-28T13:50:53.876078Z","steps":["trace[65111836] 'agreement among raft nodes before linearized reading' (duration: 129.046719ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:53.875067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.196964ms","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-04-28T13:50:53.876871Z","caller":"traceutil/trace.go:171","msg":"trace[1872953822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:615; }","duration":"169.019621ms","start":"2026-04-28T13:50:53.707843Z","end":"2026-04-28T13:50:53.876863Z","steps":["trace[1872953822] 'agreement among raft nodes before linearized reading' (duration: 167.118871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:53.877677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.902388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:53.877713Z","caller":"traceutil/trace.go:171","msg":"trace[1376664321] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:615; }","duration":"180.96895ms","start":"2026-04-28T13:50:53.696735Z","end":"2026-04-28T13:50:53.877704Z","steps":["trace[1376664321] 'agreement among raft nodes before linearized reading' (duration: 180.909739ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:55.441728Z","caller":"traceutil/trace.go:171","msg":"trace[22633348] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"141.621127ms","start":"2026-04-28T13:50:55.300068Z","end":"2026-04-28T13:50:55.441689Z","steps":["trace[22633348] 'read index received' (duration: 140.397665ms)","trace[22633348] 'applied index is now lower than readState.Index' (duration: 1.222202ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:55.44201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.917725ms","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-04-28T13:50:55.442058Z","caller":"traceutil/trace.go:171","msg":"trace[762206297] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"142.028587ms","start":"2026-04-28T13:50:55.300017Z","end":"2026-04-28T13:50:55.442045Z","steps":["trace[762206297] 'agreement among raft nodes before linearized reading' (duration: 141.814232ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:55.442189Z","caller":"traceutil/trace.go:171","msg":"trace[1297009809] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"157.833489ms","start":"2026-04-28T13:50:55.284338Z","end":"2026-04-28T13:50:55.442172Z","steps":["trace[1297009809] 'process raft request' (duration: 156.546526ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:55.599047Z","caller":"traceutil/trace.go:171","msg":"trace[1935577659] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"150.057566ms","start":"2026-04-28T13:50:55.448947Z","end":"2026-04-28T13:50:55.599004Z","steps":["trace[1935577659] 'process raft request' (duration: 93.542845ms)","trace[1935577659] 'compare' (duration: 56.226614ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:55.975048Z","caller":"traceutil/trace.go:171","msg":"trace[1383151055] linearizableReadLoop","detail":"{readStateIndex:651; appliedIndex:650; }","duration":"214.76916ms","start":"2026-04-28T13:50:55.760261Z","end":"2026-04-28T13:50:55.97503Z","steps":["trace[1383151055] 'read index received' (duration: 214.678388ms)","trace[1383151055] 'applied index is now lower than readState.Index' (duration: 88.232µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:55.975367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.057008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:55.975531Z","caller":"traceutil/trace.go:171","msg":"trace[340753010] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"215.276263ms","start":"2026-04-28T13:50:55.760215Z","end":"2026-04-28T13:50:55.975491Z","steps":["trace[340753010] 'agreement among raft nodes before linearized reading' (duration: 214.979175ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:55.976273Z","caller":"traceutil/trace.go:171","msg":"trace[1872925905] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"358.632257ms","start":"2026-04-28T13:50:55.616653Z","end":"2026-04-28T13:50:55.975286Z","steps":["trace[1872925905] 'process raft request' (duration: 358.277608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:55.976454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:55.616637Z","time spent":"359.738206ms","remote":"127.0.0.1:51634","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:50:57.261876Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1011513126702625646,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T13:50:57.27758Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.297718896s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-28T13:50:58.520301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.242391849s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:50:58.521255Z","caller":"traceutil/trace.go:171","msg":"trace[2136468876] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"2.541474038s","start":"2026-04-28T13:50:55.979745Z","end":"2026-04-28T13:50:58.521219Z","steps":["trace[2136468876] 'process raft request' (duration: 1.298061374s)","trace[2136468876] 'compare' (duration: 1.242117362s)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:58.521919Z","caller":"traceutil/trace.go:171","msg":"trace[1182456703] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"2.541753665s","start":"2026-04-28T13:50:55.980126Z","end":"2026-04-28T13:50:58.52188Z","steps":["trace[1182456703] 'process raft request' (duration: 2.540311649s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:58.522003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:55.979688Z","time spent":"2.542224226s","remote":"127.0.0.1:51708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:50:58.521938Z","caller":"traceutil/trace.go:171","msg":"trace[2005536317] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"2.541043086s","start":"2026-04-28T13:50:55.980862Z","end":"2026-04-28T13:50:58.521905Z","steps":["trace[2005536317] 'process raft request' (duration: 2.539665992s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:58.522128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:55.980116Z","time spent":"2.541906158s","remote":"127.0.0.1:51708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:50:58.522846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:55.980845Z","time spent":"2.541641063s","remote":"127.0.0.1:51708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T13:50:58.523093Z","caller":"traceutil/trace.go:171","msg":"trace[914772651] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:651; }","duration":"1.761670076s","start":"2026-04-28T13:50:56.761401Z","end":"2026-04-28T13:50:58.523071Z","steps":["trace[914772651] 'read index received' (duration: 516.413156ms)","trace[914772651] 'applied index is now lower than readState.Index' (duration: 1.24525591s)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:58.523208Z","caller":"traceutil/trace.go:171","msg":"trace[417500270] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"2.489959762s","start":"2026-04-28T13:50:56.033238Z","end":"2026-04-28T13:50:58.523197Z","steps":["trace[417500270] 'process raft request' (duration: 2.488015883s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:58.524843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.761910482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:58.524939Z","caller":"traceutil/trace.go:171","msg":"trace[275533392] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:633; }","duration":"1.763546683s","start":"2026-04-28T13:50:56.761346Z","end":"2026-04-28T13:50:58.524892Z","steps":["trace[275533392] 'agreement among raft nodes before linearized reading' (duration: 1.761925482s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:58.525008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:56.761325Z","time spent":"1.763651957s","remote":"127.0.0.1:51462","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-04-28T13:50:58.527338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:56.033204Z","time spent":"2.490029224s","remote":"127.0.0.1:51550","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T13:50:58.528053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.271561ms","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-04-28T13:50:58.528135Z","caller":"traceutil/trace.go:171","msg":"trace[2035003886] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"924.354513ms","start":"2026-04-28T13:50:57.603739Z","end":"2026-04-28T13:50:58.528094Z","steps":["trace[2035003886] 'agreement among raft nodes before linearized reading' (duration: 924.190639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:58.528165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:57.603717Z","time spent":"924.439726ms","remote":"127.0.0.1:51708","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-04-28T13:50:58.8641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.528666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T13:50:58.864405Z","caller":"traceutil/trace.go:171","msg":"trace[990778517] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"330.157616ms","start":"2026-04-28T13:50:58.534166Z","end":"2026-04-28T13:50:58.864323Z","steps":["trace[990778517] 'process raft request' (duration: 102.263311ms)","trace[990778517] 'compare' (duration: 227.32877ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T13:50:58.864543Z","caller":"traceutil/trace.go:171","msg":"trace[171847219] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"328.585237ms","start":"2026-04-28T13:50:58.535849Z","end":"2026-04-28T13:50:58.864434Z","steps":["trace[171847219] 'read index received' (duration: 100.59278ms)","trace[171847219] 'applied index is now lower than readState.Index' (duration: 227.904055ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:50:58.864646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:58.534143Z","time spent":"330.367482ms","remote":"127.0.0.1:51708","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-04-28T13:50:58.864959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.098411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:50:58.86503Z","caller":"traceutil/trace.go:171","msg":"trace[1644139589] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:635; }","duration":"329.227723ms","start":"2026-04-28T13:50:58.535781Z","end":"2026-04-28T13:50:58.865008Z","steps":["trace[1644139589] 'agreement among raft nodes before linearized reading' (duration: 329.024308ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:58.865079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:58.535766Z","time spent":"329.305775ms","remote":"127.0.0.1:51462","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-04-28T13:50:58.865334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.933417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.22\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-28T13:50:58.865335Z","caller":"traceutil/trace.go:171","msg":"trace[1773280497] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"279.300702ms","start":"2026-04-28T13:50:58.585069Z","end":"2026-04-28T13:50:58.86437Z","steps":["trace[1773280497] 'process raft request' (duration: 279.21527ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:50:58.865404Z","caller":"traceutil/trace.go:171","msg":"trace[293352756] range","detail":"{range_begin:/registry/masterleases/199.204.45.22; range_end:; response_count:1; response_revision:635; }","duration":"314.04735ms","start":"2026-04-28T13:50:58.551336Z","end":"2026-04-28T13:50:58.865383Z","steps":["trace[293352756] 'agreement among raft nodes before linearized reading' (duration: 313.682031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:50:58.865472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:50:58.551314Z","time spent":"314.147203ms","remote":"127.0.0.1:51490","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.22\" "} {"level":"info","ts":"2026-04-28T13:50:59.517449Z","caller":"traceutil/trace.go:171","msg":"trace[1112573178] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"217.106228ms","start":"2026-04-28T13:50:59.300308Z","end":"2026-04-28T13:50:59.517415Z","steps":["trace[1112573178] 'process raft request' (duration: 216.36393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:01.023313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.410327ms","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-04-28T13:51:01.023397Z","caller":"traceutil/trace.go:171","msg":"trace[1994966565] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:675; }","duration":"152.587122ms","start":"2026-04-28T13:51:00.870795Z","end":"2026-04-28T13:51:01.023382Z","steps":["trace[1994966565] 'range keys from in-memory index tree' (duration: 152.204072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:01.023426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.21288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:01.023505Z","caller":"traceutil/trace.go:171","msg":"trace[798001716] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:675; }","duration":"185.573679ms","start":"2026-04-28T13:51:00.837905Z","end":"2026-04-28T13:51:01.023478Z","steps":["trace[798001716] 'range keys from in-memory index tree' (duration: 185.103087ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.873872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"533.438598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:14.873947Z","caller":"traceutil/trace.go:171","msg":"trace[1461124891] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:797; }","duration":"533.581321ms","start":"2026-04-28T13:51:14.340352Z","end":"2026-04-28T13:51:14.873933Z","steps":["trace[1461124891] 'agreement among raft nodes before linearized reading' (duration: 533.424787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.873985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T13:51:14.340332Z","time spent":"533.645232ms","remote":"127.0.0.1:51938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-04-28T13:51:14.874336Z","caller":"traceutil/trace.go:171","msg":"trace[44531935] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"180.997558ms","start":"2026-04-28T13:51:14.693314Z","end":"2026-04-28T13:51:14.874311Z","steps":["trace[44531935] 'process raft request' (duration: 180.796894ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:51:14.873719Z","caller":"traceutil/trace.go:171","msg":"trace[1918957222] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"533.271783ms","start":"2026-04-28T13:51:14.340391Z","end":"2026-04-28T13:51:14.873663Z","steps":["trace[1918957222] 'read index received' (duration: 436.762905ms)","trace[1918957222] 'applied index is now lower than readState.Index' (duration: 96.507308ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T13:51:14.874884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.151277ms","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-04-28T13:51:14.874951Z","caller":"traceutil/trace.go:171","msg":"trace[186474491] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:798; }","duration":"148.228429ms","start":"2026-04-28T13:51:14.726683Z","end":"2026-04-28T13:51:14.874911Z","steps":["trace[186474491] 'agreement among raft nodes before linearized reading' (duration: 148.094196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.874969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.384055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T13:51:14.87501Z","caller":"traceutil/trace.go:171","msg":"trace[1422127032] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:798; }","duration":"113.450537ms","start":"2026-04-28T13:51:14.76155Z","end":"2026-04-28T13:51:14.875001Z","steps":["trace[1422127032] 'agreement among raft nodes before linearized reading' (duration: 113.334714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.875379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.149157ms","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-04-28T13:51:14.875405Z","caller":"traceutil/trace.go:171","msg":"trace[1560141898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:798; }","duration":"263.202018ms","start":"2026-04-28T13:51:14.612196Z","end":"2026-04-28T13:51:14.875398Z","steps":["trace[1560141898] 'agreement among raft nodes before linearized reading' (duration: 262.603005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.875552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.951147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T13:51:14.875633Z","caller":"traceutil/trace.go:171","msg":"trace[1673014923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:798; }","duration":"272.08762ms","start":"2026-04-28T13:51:14.603523Z","end":"2026-04-28T13:51:14.875611Z","steps":["trace[1673014923] 'agreement among raft nodes before linearized reading' (duration: 271.294043ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T13:51:14.875909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.420816ms","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-04-28T13:51:14.876304Z","caller":"traceutil/trace.go:171","msg":"trace[97849053] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:798; }","duration":"265.884686ms","start":"2026-04-28T13:51:14.610377Z","end":"2026-04-28T13:51:14.876261Z","steps":["trace[97849053] 'agreement among raft nodes before linearized reading' (duration: 264.481756ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T13:53:10.467668Z","caller":"traceutil/trace.go:171","msg":"trace[1497716364] transaction","detail":"{read_only:false; response_revision:1350; number_of_response:1; }","duration":"207.743745ms","start":"2026-04-28T13:53:10.259886Z","end":"2026-04-28T13:53:10.46763Z","steps":["trace[1497716364] 'process raft request' (duration: 207.536933ms)"],"step_count":1}