{"level":"warn","ts":"2026-03-26T08:30:37.328363Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T08:30:37.328459Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.69: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.69:2380","--initial-cluster=instance=https://199.204.45.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.69: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-03-26T08:30:37.328523Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-26T08:30:37.328537Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-03-26T08:30:37.328557Z","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-03-26T08:30:37.329123Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"]} {"level":"info","ts":"2026-03-26T08:30:37.329207Z","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.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.69: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-03-26T08:30:37.335216Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.787519ms"} {"level":"info","ts":"2026-03-26T08:30:37.343537Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe334179879fd0aa","cluster-id":"d79a8cccc23ced73"} {"level":"info","ts":"2026-03-26T08:30:37.343621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=()"} {"level":"info","ts":"2026-03-26T08:30:37.343643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 0"} {"level":"info","ts":"2026-03-26T08:30:37.343663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe334179879fd0aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-26T08:30:37.343719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 1"} {"level":"info","ts":"2026-03-26T08:30:37.343784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"warn","ts":"2026-03-26T08:30:37.350939Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-26T08:30:37.353577Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-26T08:30:37.355215Z","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-03-26T08:30:37.357743Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe334179879fd0aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-26T08:30:37.357926Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe334179879fd0aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-26T08:30:37.358004Z","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-03-26T08:30:37.358055Z","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-03-26T08:30:37.358064Z","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-03-26T08:30:37.358814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"info","ts":"2026-03-26T08:30:37.359087Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","added-peer-id":"fe334179879fd0aa","added-peer-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-03-26T08:30:37.360577Z","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-03-26T08:30:37.360682Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-03-26T08:30:37.360703Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-03-26T08:30:37.360895Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe334179879fd0aa","initial-advertise-peer-urls":["https://199.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-26T08:30:37.360923Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-26T08:30:37.845024Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa is starting a new election at term 1"} {"level":"info","ts":"2026-03-26T08:30:37.845112Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became pre-candidate at term 1"} {"level":"info","ts":"2026-03-26T08:30:37.845138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgPreVoteResp from fe334179879fd0aa at term 1"} {"level":"info","ts":"2026-03-26T08:30:37.845157Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became candidate at term 2"} {"level":"info","ts":"2026-03-26T08:30:37.845169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgVoteResp from fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-03-26T08:30:37.845185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became leader at term 2"} {"level":"info","ts":"2026-03-26T08:30:37.845199Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe334179879fd0aa elected leader fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-03-26T08:30:37.8463Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T08:30:37.84797Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T08:30:37.848076Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T08:30:37.848114Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-26T08:30:37.848161Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe334179879fd0aa","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.69:2379]}","request-path":"/0/members/fe334179879fd0aa/attributes","cluster-id":"d79a8cccc23ced73","publish-timeout":"7s"} {"level":"info","ts":"2026-03-26T08:30:37.849628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T08:30:37.849789Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-26T08:30:37.849847Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-26T08:30:37.849741Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-26T08:30:37.852411Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.69:2379"} {"level":"info","ts":"2026-03-26T08:30:37.853857Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-03-26T08:30:42.726701Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003106495472237,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T08:30:43.491922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.957907ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-03-26T08:30:43.492055Z","caller":"traceutil/trace.go:171","msg":"trace[382013392] linearizableReadLoop","detail":"{readStateIndex:273; appliedIndex:272; }","duration":"1.266144803s","start":"2026-03-26T08:30:42.225894Z","end":"2026-03-26T08:30:43.492038Z","steps":["trace[382013392] 'read index received' (duration: 793.551193ms)","trace[382013392] 'applied index is now lower than readState.Index' (duration: 472.59248ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:30:43.49221Z","caller":"traceutil/trace.go:171","msg":"trace[406372594] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"1.294426086s","start":"2026-03-26T08:30:42.197772Z","end":"2026-03-26T08:30:43.492198Z","steps":["trace[406372594] 'process raft request' (duration: 821.685843ms)","trace[406372594] 'compare' (duration: 471.801464ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T08:30:43.494856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268903648s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T08:30:43.494991Z","caller":"traceutil/trace.go:171","msg":"trace[1567553729] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:0; response_revision:267; }","duration":"1.269108662s","start":"2026-03-26T08:30:42.225833Z","end":"2026-03-26T08:30:43.494942Z","steps":["trace[1567553729] 'agreement among raft nodes before linearized reading' (duration: 1.267207173s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:43.49507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:42.225813Z","time spent":"1.269244394s","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-03-26T08:30:43.495395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:42.197732Z","time spent":"1.297470957s","remote":"127.0.0.1:59976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":677,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T08:30:43.992267Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003106495472241,"retry-timeout":"500ms"} {"level":"info","ts":"2026-03-26T08:30:44.005819Z","caller":"traceutil/trace.go:171","msg":"trace[959482731] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:273; }","duration":"513.656227ms","start":"2026-03-26T08:30:43.492136Z","end":"2026-03-26T08:30:44.005793Z","steps":["trace[959482731] 'read index received' (duration: 505.68896ms)","trace[959482731] 'applied index is now lower than readState.Index' (duration: 7.966227ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:30:44.006031Z","caller":"traceutil/trace.go:171","msg":"trace[2131712368] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"576.668487ms","start":"2026-03-26T08:30:43.429332Z","end":"2026-03-26T08:30:44.006001Z","steps":["trace[2131712368] 'process raft request' (duration: 568.483265ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:44.006171Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:43.429301Z","time spent":"576.79975ms","remote":"127.0.0.1:60074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:30:44.006311Z","caller":"traceutil/trace.go:171","msg":"trace[907480164] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"504.311213ms","start":"2026-03-26T08:30:43.50198Z","end":"2026-03-26T08:30:44.006269Z","steps":["trace[907480164] 'process raft request' (duration: 503.754001ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:44.006475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:43.501963Z","time spent":"504.408244ms","remote":"127.0.0.1:60210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":290,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T08:30:44.006637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.145081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-26T08:30:44.006691Z","caller":"traceutil/trace.go:171","msg":"trace[573630714] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:269; }","duration":"781.268293ms","start":"2026-03-26T08:30:43.225409Z","end":"2026-03-26T08:30:44.006677Z","steps":["trace[573630714] 'agreement among raft nodes before linearized reading' (duration: 781.166481ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:44.006711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.222153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-03-26T08:30:44.00673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:43.22535Z","time spent":"781.372575ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T08:30:44.006753Z","caller":"traceutil/trace.go:171","msg":"trace[848111918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:269; }","duration":"892.314435ms","start":"2026-03-26T08:30:43.114426Z","end":"2026-03-26T08:30:44.006741Z","steps":["trace[848111918] 'agreement among raft nodes before linearized reading' (duration: 892.238534ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:44.006525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.482056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"warn","ts":"2026-03-26T08:30:44.006786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:43.114404Z","time spent":"892.376296ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-26T08:30:44.00687Z","caller":"traceutil/trace.go:171","msg":"trace[43448701] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:269; }","duration":"505.829353ms","start":"2026-03-26T08:30:43.500983Z","end":"2026-03-26T08:30:44.006812Z","steps":["trace[43448701] 'agreement among raft nodes before linearized reading' (duration: 505.372754ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:44.006952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.964026ms","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-03-26T08:30:44.006983Z","caller":"traceutil/trace.go:171","msg":"trace[1787623926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:269; }","duration":"323.032497ms","start":"2026-03-26T08:30:43.683941Z","end":"2026-03-26T08:30:44.006974Z","steps":["trace[1787623926] 'agreement among raft nodes before linearized reading' (duration: 322.971266ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:44.007012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:43.683919Z","time spent":"323.086638ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-26T08:30:44.007239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.603586609s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T08:30:44.007442Z","caller":"traceutil/trace.go:171","msg":"trace[912381384] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:269; }","duration":"1.603844834s","start":"2026-03-26T08:30:42.403577Z","end":"2026-03-26T08:30:44.007422Z","steps":["trace[912381384] 'agreement among raft nodes before linearized reading' (duration: 1.602734902s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:44.007598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:42.403543Z","time spent":"1.603965337s","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-26T08:30:44.008289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:30:43.500964Z","time spent":"505.988485ms","remote":"127.0.0.1:60004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-03-26T08:30:47.321879Z","caller":"traceutil/trace.go:171","msg":"trace[475117612] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:379; }","duration":"180.314609ms","start":"2026-03-26T08:30:47.141538Z","end":"2026-03-26T08:30:47.321852Z","steps":["trace[475117612] 'read index received' (duration: 167.653453ms)","trace[475117612] 'applied index is now lower than readState.Index' (duration: 12.659486ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:30:47.321951Z","caller":"traceutil/trace.go:171","msg":"trace[1764414688] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"198.092425ms","start":"2026-03-26T08:30:47.123804Z","end":"2026-03-26T08:30:47.321896Z","steps":["trace[1764414688] 'process raft request' (duration: 185.445319ms)","trace[1764414688] 'compare' (duration: 12.478403ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T08:30:47.32211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.547653ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T08:30:47.322219Z","caller":"traceutil/trace.go:171","msg":"trace[949264402] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:368; }","duration":"180.671735ms","start":"2026-03-26T08:30:47.141529Z","end":"2026-03-26T08:30:47.322201Z","steps":["trace[949264402] 'agreement among raft nodes before linearized reading' (duration: 180.477982ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:47.322636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.99738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-03-26T08:30:47.32271Z","caller":"traceutil/trace.go:171","msg":"trace[783630558] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:368; }","duration":"111.132733ms","start":"2026-03-26T08:30:47.211558Z","end":"2026-03-26T08:30:47.322691Z","steps":["trace[783630558] 'agreement among raft nodes before linearized reading' (duration: 110.525251ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:30:47.324148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.875911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-03-26T08:30:47.324205Z","caller":"traceutil/trace.go:171","msg":"trace[1061721] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:368; }","duration":"161.451853ms","start":"2026-03-26T08:30:47.162738Z","end":"2026-03-26T08:30:47.32419Z","steps":["trace[1061721] 'agreement among raft nodes before linearized reading' (duration: 159.315451ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:07.588042Z","caller":"traceutil/trace.go:171","msg":"trace[1405115472] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"404.463263ms","start":"2026-03-26T08:31:07.183543Z","end":"2026-03-26T08:31:07.588006Z","steps":["trace[1405115472] 'process raft request' (duration: 403.992755ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.588297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.183511Z","time spent":"404.706818ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.739458Z","caller":"traceutil/trace.go:171","msg":"trace[214428659] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"552.862689ms","start":"2026-03-26T08:31:07.186496Z","end":"2026-03-26T08:31:07.739359Z","steps":["trace[214428659] 'process raft request' (duration: 552.569724ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:07.739592Z","caller":"traceutil/trace.go:171","msg":"trace[791456715] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"552.20153ms","start":"2026-03-26T08:31:07.187361Z","end":"2026-03-26T08:31:07.739563Z","steps":["trace[791456715] 'process raft request' (duration: 551.884443ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.73972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.186471Z","time spent":"553.127365ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T08:31:07.739746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.187351Z","time spent":"552.316101ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.739755Z","caller":"traceutil/trace.go:171","msg":"trace[678291374] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"542.871242ms","start":"2026-03-26T08:31:07.196815Z","end":"2026-03-26T08:31:07.739686Z","steps":["trace[678291374] 'process raft request' (duration: 542.531025ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.739959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.196797Z","time spent":"543.054495ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.740207Z","caller":"traceutil/trace.go:171","msg":"trace[619017689] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"538.212488ms","start":"2026-03-26T08:31:07.201982Z","end":"2026-03-26T08:31:07.740194Z","steps":["trace[619017689] 'process raft request' (duration: 537.572587ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.740273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.201966Z","time spent":"538.276168ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.740433Z","caller":"traceutil/trace.go:171","msg":"trace[1199235552] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"536.06254ms","start":"2026-03-26T08:31:07.204328Z","end":"2026-03-26T08:31:07.74039Z","steps":["trace[1199235552] 'process raft request' (duration: 535.766525ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.740589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.204307Z","time spent":"536.210812ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.740863Z","caller":"traceutil/trace.go:171","msg":"trace[1707699740] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"536.446117ms","start":"2026-03-26T08:31:07.204401Z","end":"2026-03-26T08:31:07.740847Z","steps":["trace[1707699740] 'process raft request' (duration: 536.006039ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.740937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.204398Z","time spent":"536.508339ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.741072Z","caller":"traceutil/trace.go:171","msg":"trace[1598632941] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"534.735375ms","start":"2026-03-26T08:31:07.206321Z","end":"2026-03-26T08:31:07.741056Z","steps":["trace[1598632941] 'process raft request' (duration: 534.177325ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.741253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.206313Z","time spent":"534.813787ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.741629Z","caller":"traceutil/trace.go:171","msg":"trace[759542359] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"534.38716ms","start":"2026-03-26T08:31:07.207229Z","end":"2026-03-26T08:31:07.741616Z","steps":["trace[759542359] 'process raft request' (duration: 533.966353ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:07.741792Z","caller":"traceutil/trace.go:171","msg":"trace[1676702854] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"529.184917ms","start":"2026-03-26T08:31:07.21259Z","end":"2026-03-26T08:31:07.741775Z","steps":["trace[1676702854] 'process raft request' (duration: 528.81534ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.741937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.21258Z","time spent":"529.251708ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.742275Z","caller":"traceutil/trace.go:171","msg":"trace[924785258] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"502.348506ms","start":"2026-03-26T08:31:07.239911Z","end":"2026-03-26T08:31:07.742259Z","steps":["trace[924785258] 'process raft request' (duration: 501.643073ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.742346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.239893Z","time spent":"502.422007ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-03-26T08:31:07.742667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.207201Z","time spent":"534.465701ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.743732Z","caller":"traceutil/trace.go:171","msg":"trace[1644459386] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"398.354614ms","start":"2026-03-26T08:31:07.345314Z","end":"2026-03-26T08:31:07.743668Z","steps":["trace[1644459386] 'process raft request' (duration: 396.587452ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:07.743998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:07.345287Z","time spent":"398.611128ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:07.747694Z","caller":"traceutil/trace.go:171","msg":"trace[1333002531] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"153.763242ms","start":"2026-03-26T08:31:07.593913Z","end":"2026-03-26T08:31:07.747676Z","steps":["trace[1333002531] 'process raft request' (duration: 153.125661ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:07.747721Z","caller":"traceutil/trace.go:171","msg":"trace[1782137562] transaction","detail":"{read_only:false; number_of_response:1; response_revision:527; }","duration":"151.073056ms","start":"2026-03-26T08:31:07.596634Z","end":"2026-03-26T08:31:07.747707Z","steps":["trace[1782137562] 'process raft request' (duration: 151.044395ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:07.747869Z","caller":"traceutil/trace.go:171","msg":"trace[753979238] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"153.827705ms","start":"2026-03-26T08:31:07.594034Z","end":"2026-03-26T08:31:07.747862Z","steps":["trace[753979238] 'process raft request' (duration: 153.60343ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:13.552365Z","caller":"traceutil/trace.go:171","msg":"trace[8607208] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"358.561886ms","start":"2026-03-26T08:31:13.193778Z","end":"2026-03-26T08:31:13.55234Z","steps":["trace[8607208] 'process raft request' (duration: 356.574341ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:13.552663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:13.193755Z","time spent":"358.678278ms","remote":"127.0.0.1:59976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T08:31:14.524991Z","caller":"traceutil/trace.go:171","msg":"trace[1074007118] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"365.130179ms","start":"2026-03-26T08:31:14.159829Z","end":"2026-03-26T08:31:14.524959Z","steps":["trace[1074007118] 'read index received' (duration: 364.157972ms)","trace[1074007118] 'applied index is now lower than readState.Index' (duration: 971.027µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:31:14.525068Z","caller":"traceutil/trace.go:171","msg":"trace[479691547] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"523.948583ms","start":"2026-03-26T08:31:14.001061Z","end":"2026-03-26T08:31:14.525009Z","steps":["trace[479691547] 'process raft request' (duration: 523.301451ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:14.525278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.417954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-03-26T08:31:14.5253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.001036Z","time spent":"524.143977ms","remote":"127.0.0.1:59976","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T08:31:14.525318Z","caller":"traceutil/trace.go:171","msg":"trace[968697679] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"365.554976ms","start":"2026-03-26T08:31:14.159752Z","end":"2026-03-26T08:31:14.525307Z","steps":["trace[968697679] 'agreement among raft nodes before linearized reading' (duration: 365.366573ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:14.525352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.159717Z","time spent":"365.628298ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-03-26T08:31:14.525786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"357.257111ms","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-03-26T08:31:14.52576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.35331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-03-26T08:31:14.525911Z","caller":"traceutil/trace.go:171","msg":"trace[1897779088] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"362.514762ms","start":"2026-03-26T08:31:14.163342Z","end":"2026-03-26T08:31:14.525857Z","steps":["trace[1897779088] 'agreement among raft nodes before linearized reading' (duration: 362.193277ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:14.525952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.159758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-03-26T08:31:14.525963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.163328Z","time spent":"362.624556ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T08:31:14.52583Z","caller":"traceutil/trace.go:171","msg":"trace[597512749] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"357.345663ms","start":"2026-03-26T08:31:14.168475Z","end":"2026-03-26T08:31:14.525821Z","steps":["trace[597512749] 'agreement among raft nodes before linearized reading' (duration: 357.16851ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:14.525981Z","caller":"traceutil/trace.go:171","msg":"trace[2077339768] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"362.199248ms","start":"2026-03-26T08:31:14.163773Z","end":"2026-03-26T08:31:14.525972Z","steps":["trace[2077339768] 'agreement among raft nodes before linearized reading' (duration: 362.080155ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:14.526015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.163762Z","time spent":"362.247869ms","remote":"127.0.0.1:60124","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-03-26T08:31:14.526015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.168457Z","time spent":"357.546187ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-03-26T08:31:15.104019Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003106495472909,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T08:31:16.313913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:16.000974Z","time spent":"312.931841ms","remote":"127.0.0.1:59614","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-03-26T08:31:16.314048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"871.555638ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-26T08:31:16.314303Z","caller":"traceutil/trace.go:171","msg":"trace[1424704223] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:647; }","duration":"1.711295393s","start":"2026-03-26T08:31:14.60299Z","end":"2026-03-26T08:31:16.314285Z","steps":["trace[1424704223] 'read index received' (duration: 839.47487ms)","trace[1424704223] 'applied index is now lower than readState.Index' (duration: 871.819533ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:31:16.314385Z","caller":"traceutil/trace.go:171","msg":"trace[1456074946] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.233427049s","start":"2026-03-26T08:31:15.080934Z","end":"2026-03-26T08:31:16.314361Z","steps":["trace[1456074946] 'process raft request' (duration: 1.233217186s)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:16.314428Z","caller":"traceutil/trace.go:171","msg":"trace[690741364] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.720713878s","start":"2026-03-26T08:31:14.593694Z","end":"2026-03-26T08:31:16.314408Z","steps":["trace[690741364] 'process raft request' (duration: 848.707062ms)","trace[690741364] 'compare' (duration: 871.299313ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:31:16.314499Z","caller":"traceutil/trace.go:171","msg":"trace[294727897] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"939.890767ms","start":"2026-03-26T08:31:15.374595Z","end":"2026-03-26T08:31:16.314486Z","steps":["trace[294727897] 'process raft request' (duration: 939.648973ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:16.314529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.593679Z","time spent":"1.720787629s","remote":"127.0.0.1:60074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T08:31:16.314531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:15.080914Z","time spent":"1.233540191s","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T08:31:16.314564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:15.374576Z","time spent":"939.954598ms","remote":"127.0.0.1:60072","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4538,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-03-26T08:31:16.314734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.7117424s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T08:31:16.314765Z","caller":"traceutil/trace.go:171","msg":"trace[595816876] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:628; }","duration":"1.711797051s","start":"2026-03-26T08:31:14.602956Z","end":"2026-03-26T08:31:16.314753Z","steps":["trace[595816876] 'agreement among raft nodes before linearized reading' (duration: 1.711749381s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:16.314796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.602945Z","time spent":"1.711845122s","remote":"127.0.0.1:60104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-03-26T08:31:16.326209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.352502963s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T08:31:16.326257Z","caller":"traceutil/trace.go:171","msg":"trace[1199809408] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"1.352562215s","start":"2026-03-26T08:31:14.973684Z","end":"2026-03-26T08:31:16.326246Z","steps":["trace[1199809408] 'agreement among raft nodes before linearized reading' (duration: 1.352480234s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:16.326286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:14.973621Z","time spent":"1.352659856s","remote":"127.0.0.1:47254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-03-26T08:31:18.14968Z","caller":"traceutil/trace.go:171","msg":"trace[861260322] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"176.408613ms","start":"2026-03-26T08:31:17.973247Z","end":"2026-03-26T08:31:18.149656Z","steps":["trace[861260322] 'read index received' (duration: 176.084436ms)","trace[861260322] 'applied index is now lower than readState.Index' (duration: 323.067µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:31:18.149794Z","caller":"traceutil/trace.go:171","msg":"trace[37055615] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"364.594408ms","start":"2026-03-26T08:31:17.785166Z","end":"2026-03-26T08:31:18.149761Z","steps":["trace[37055615] 'process raft request' (duration: 364.17038ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:18.149936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.680018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T08:31:18.149987Z","caller":"traceutil/trace.go:171","msg":"trace[76392305] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:663; }","duration":"176.81268ms","start":"2026-03-26T08:31:17.973162Z","end":"2026-03-26T08:31:18.149974Z","steps":["trace[76392305] 'agreement among raft nodes before linearized reading' (duration: 176.582306ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:18.149978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:17.785137Z","time spent":"364.743831ms","remote":"127.0.0.1:47300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-03-26T08:31:18.15874Z","caller":"traceutil/trace.go:171","msg":"trace[1284482393] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"172.661847ms","start":"2026-03-26T08:31:17.986053Z","end":"2026-03-26T08:31:18.158715Z","steps":["trace[1284482393] 'process raft request' (duration: 172.539825ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:20.951513Z","caller":"traceutil/trace.go:171","msg":"trace[1803375260] linearizableReadLoop","detail":"{readStateIndex:732; appliedIndex:731; }","duration":"168.225943ms","start":"2026-03-26T08:31:20.783258Z","end":"2026-03-26T08:31:20.951484Z","steps":["trace[1803375260] 'read index received' (duration: 164.349626ms)","trace[1803375260] 'applied index is now lower than readState.Index' (duration: 3.873827ms)"],"step_count":2} {"level":"warn","ts":"2026-03-26T08:31:20.951776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.499387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-03-26T08:31:20.951823Z","caller":"traceutil/trace.go:171","msg":"trace[2011049295] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:708; }","duration":"168.581358ms","start":"2026-03-26T08:31:20.783228Z","end":"2026-03-26T08:31:20.951809Z","steps":["trace[2011049295] 'agreement among raft nodes before linearized reading' (duration: 168.357164ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:28.117538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.884479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-26T08:31:28.117617Z","caller":"traceutil/trace.go:171","msg":"trace[1765878418] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:780; }","duration":"144.026171ms","start":"2026-03-26T08:31:27.973574Z","end":"2026-03-26T08:31:28.1176Z","steps":["trace[1765878418] 'range keys from in-memory index tree' (duration: 143.782817ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.148242Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003106495473280,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-03-26T08:31:31.641125Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.262246962s","expected-duration":"1s"} {"level":"info","ts":"2026-03-26T08:31:31.641688Z","caller":"traceutil/trace.go:171","msg":"trace[190637520] linearizableReadLoop","detail":"{readStateIndex:820; appliedIndex:819; }","duration":"993.876716ms","start":"2026-03-26T08:31:30.647788Z","end":"2026-03-26T08:31:31.641665Z","steps":["trace[190637520] 'read index received' (duration: 993.506051ms)","trace[190637520] 'applied index is now lower than readState.Index' (duration: 369.795µs)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:31:31.641772Z","caller":"traceutil/trace.go:171","msg":"trace[646628852] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"1.262972494s","start":"2026-03-26T08:31:30.378763Z","end":"2026-03-26T08:31:31.641735Z","steps":["trace[646628852] 'process raft request' (duration: 1.26274428s)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.641967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"993.552352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-03-26T08:31:31.641967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.159862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wgnlk\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-03-26T08:31:31.642016Z","caller":"traceutil/trace.go:171","msg":"trace[1252825306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"993.631873ms","start":"2026-03-26T08:31:30.648372Z","end":"2026-03-26T08:31:31.642004Z","steps":["trace[1252825306] 'agreement among raft nodes before linearized reading' (duration: 993.46452ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.64205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:30.648363Z","time spent":"993.679553ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-03-26T08:31:31.642047Z","caller":"traceutil/trace.go:171","msg":"trace[2051847014] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wgnlk; range_end:; response_count:1; response_revision:794; }","duration":"994.335424ms","start":"2026-03-26T08:31:30.647691Z","end":"2026-03-26T08:31:31.642026Z","steps":["trace[2051847014] 'agreement among raft nodes before linearized reading' (duration: 994.09188ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.64206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"865.210245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.69\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-03-26T08:31:31.642102Z","caller":"traceutil/trace.go:171","msg":"trace[817086781] range","detail":"{range_begin:/registry/masterleases/199.204.45.69; range_end:; response_count:1; response_revision:794; }","duration":"865.259936ms","start":"2026-03-26T08:31:30.776831Z","end":"2026-03-26T08:31:31.642091Z","steps":["trace[817086781] 'agreement among raft nodes before linearized reading' (duration: 865.079163ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.642101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:30.647663Z","time spent":"994.428315ms","remote":"127.0.0.1:60074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wgnlk\" "} {"level":"warn","ts":"2026-03-26T08:31:31.642067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"976.072901ms","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-03-26T08:31:31.64214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:30.776817Z","time spent":"865.315117ms","remote":"127.0.0.1:47284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.69\" "} {"level":"warn","ts":"2026-03-26T08:31:31.642223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"987.5059ms","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-03-26T08:31:31.642186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"977.295781ms","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-03-26T08:31:31.642265Z","caller":"traceutil/trace.go:171","msg":"trace[486417673] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"987.589722ms","start":"2026-03-26T08:31:30.654665Z","end":"2026-03-26T08:31:31.642255Z","steps":["trace[486417673] 'agreement among raft nodes before linearized reading' (duration: 987.48875ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.642298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:30.654635Z","time spent":"987.654272ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-03-26T08:31:31.642306Z","caller":"traceutil/trace.go:171","msg":"trace[380826341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"977.462873ms","start":"2026-03-26T08:31:30.664816Z","end":"2026-03-26T08:31:31.642279Z","steps":["trace[380826341] 'agreement among raft nodes before linearized reading' (duration: 977.084307ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.642367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:30.6648Z","time spent":"977.557444ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-03-26T08:31:31.642222Z","caller":"traceutil/trace.go:171","msg":"trace[724501802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:794; }","duration":"976.201052ms","start":"2026-03-26T08:31:30.665965Z","end":"2026-03-26T08:31:31.642166Z","steps":["trace[724501802] 'agreement among raft nodes before linearized reading' (duration: 975.906538ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.642448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:30.665953Z","time spent":"976.483567ms","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-03-26T08:31:31.642556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-26T08:31:30.378664Z","time spent":"1.263199157s","remote":"127.0.0.1:60124","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-26T08:31:31.839996Z","caller":"traceutil/trace.go:171","msg":"trace[584249189] linearizableReadLoop","detail":"{readStateIndex:826; appliedIndex:820; }","duration":"155.840276ms","start":"2026-03-26T08:31:31.684135Z","end":"2026-03-26T08:31:31.839975Z","steps":["trace[584249189] 'read index received' (duration: 146.724794ms)","trace[584249189] 'applied index is now lower than readState.Index' (duration: 9.114252ms)"],"step_count":2} {"level":"info","ts":"2026-03-26T08:31:31.840151Z","caller":"traceutil/trace.go:171","msg":"trace[1732268192] transaction","detail":"{read_only:false; response_revision:796; number_of_response:1; }","duration":"189.867191ms","start":"2026-03-26T08:31:31.650265Z","end":"2026-03-26T08:31:31.840132Z","steps":["trace[1732268192] 'process raft request' (duration: 189.541975ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:31.840054Z","caller":"traceutil/trace.go:171","msg":"trace[702469009] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"189.694528ms","start":"2026-03-26T08:31:31.650319Z","end":"2026-03-26T08:31:31.840014Z","steps":["trace[702469009] 'process raft request' (duration: 189.526444ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:31.840078Z","caller":"traceutil/trace.go:171","msg":"trace[1402807623] transaction","detail":"{read_only:false; response_revision:795; number_of_response:1; }","duration":"189.844791ms","start":"2026-03-26T08:31:31.650209Z","end":"2026-03-26T08:31:31.840054Z","steps":["trace[1402807623] 'process raft request' (duration: 189.462734ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:31.840319Z","caller":"traceutil/trace.go:171","msg":"trace[105855803] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"189.598936ms","start":"2026-03-26T08:31:31.650695Z","end":"2026-03-26T08:31:31.840294Z","steps":["trace[105855803] 'process raft request' (duration: 189.183589ms)"],"step_count":1} {"level":"info","ts":"2026-03-26T08:31:31.840404Z","caller":"traceutil/trace.go:171","msg":"trace[1642004966] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"189.523875ms","start":"2026-03-26T08:31:31.650866Z","end":"2026-03-26T08:31:31.84039Z","steps":["trace[1642004966] 'process raft request' (duration: 189.074248ms)"],"step_count":1} {"level":"warn","ts":"2026-03-26T08:31:31.840394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.225692ms","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-03-26T08:31:31.841049Z","caller":"traceutil/trace.go:171","msg":"trace[2034595437] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:799; }","duration":"156.949504ms","start":"2026-03-26T08:31:31.684088Z","end":"2026-03-26T08:31:31.841038Z","steps":["trace[2034595437] 'agreement among raft nodes before linearized reading' (duration: 156.155212ms)"],"step_count":1}