{"level":"warn","ts":"2026-02-25T09:59:50.365566Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T09:59:50.36574Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.102:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.102:2380","--initial-cluster=instance=https://199.204.45.102:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.102:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.102:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-25T09:59:50.36604Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-25T09:59:50.366091Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-02-25T09:59:50.36619Z","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-02-25T09:59:50.36731Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"]} {"level":"info","ts":"2026-02-25T09:59:50.367435Z","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.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.102:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-25T09:59:50.372496Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.779165ms"} {"level":"info","ts":"2026-02-25T09:59:50.379138Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6e7960f761c1028e","cluster-id":"502e2b31b867adf"} {"level":"info","ts":"2026-02-25T09:59:50.379341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=()"} {"level":"info","ts":"2026-02-25T09:59:50.379375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 0"} {"level":"info","ts":"2026-02-25T09:59:50.379392Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6e7960f761c1028e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-25T09:59:50.379405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became follower at term 1"} {"level":"info","ts":"2026-02-25T09:59:50.379497Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"warn","ts":"2026-02-25T09:59:50.389015Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-25T09:59:50.391087Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-25T09:59:50.392668Z","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-02-25T09:59:50.395933Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6e7960f761c1028e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-25T09:59:50.396554Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6e7960f761c1028e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-25T09:59:50.396724Z","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-02-25T09:59:50.397436Z","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-02-25T09:59:50.397492Z","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-02-25T09:59:50.398166Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e switched to configuration voters=(7960500431967289998)"} {"level":"info","ts":"2026-02-25T09:59:50.398603Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","added-peer-id":"6e7960f761c1028e","added-peer-peer-urls":["https://199.204.45.102:2380"]} {"level":"info","ts":"2026-02-25T09:59:50.402697Z","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-02-25T09:59:50.402848Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-02-25T09:59:50.402878Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.102:2380"} {"level":"info","ts":"2026-02-25T09:59:50.403291Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6e7960f761c1028e","initial-advertise-peer-urls":["https://199.204.45.102:2380"],"listen-peer-urls":["https://199.204.45.102:2380"],"advertise-client-urls":["https://199.204.45.102:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.102:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-25T09:59:50.40349Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-25T09:59:51.080638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e is starting a new election at term 1"} {"level":"info","ts":"2026-02-25T09:59:51.080727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became pre-candidate at term 1"} {"level":"info","ts":"2026-02-25T09:59:51.080808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgPreVoteResp from 6e7960f761c1028e at term 1"} {"level":"info","ts":"2026-02-25T09:59:51.080842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became candidate at term 2"} {"level":"info","ts":"2026-02-25T09:59:51.080857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e received MsgVoteResp from 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-02-25T09:59:51.08088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6e7960f761c1028e became leader at term 2"} {"level":"info","ts":"2026-02-25T09:59:51.0809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6e7960f761c1028e elected leader 6e7960f761c1028e at term 2"} {"level":"info","ts":"2026-02-25T09:59:51.082138Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T09:59:51.083091Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6e7960f761c1028e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.102:2379]}","request-path":"/0/members/6e7960f761c1028e/attributes","cluster-id":"502e2b31b867adf","publish-timeout":"7s"} {"level":"info","ts":"2026-02-25T09:59:51.08317Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T09:59:51.083633Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-25T09:59:51.083713Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-25T09:59:51.083773Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-25T09:59:51.087089Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"502e2b31b867adf","local-member-id":"6e7960f761c1028e","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T09:59:51.087256Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T09:59:51.087302Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-25T09:59:51.089881Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.102:2379"} {"level":"info","ts":"2026-02-25T09:59:51.090528Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-02-25T10:00:03.150129Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184256795271196204,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T10:00:03.214229Z","caller":"traceutil/trace.go:171","msg":"trace[883827659] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"702.926977ms","start":"2026-02-25T10:00:02.510901Z","end":"2026-02-25T10:00:03.213827Z","steps":["trace[883827659] 'process raft request' (duration: 702.757208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:03.21487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:02.510876Z","time spent":"703.471684ms","remote":"127.0.0.1:33710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6883,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:03.215717Z","caller":"traceutil/trace.go:171","msg":"trace[12176040] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:361; }","duration":"566.352314ms","start":"2026-02-25T10:00:02.649318Z","end":"2026-02-25T10:00:03.21567Z","steps":["trace[12176040] 'read index received' (duration: 564.27903ms)","trace[12176040] 'applied index is now lower than readState.Index' (duration: 1.983699ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:03.216311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.204848ms","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-02-25T10:00:03.216492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.78352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-02-25T10:00:03.216184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.859809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-25T10:00:03.216761Z","caller":"traceutil/trace.go:171","msg":"trace[1309658265] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"297.472154ms","start":"2026-02-25T10:00:02.919244Z","end":"2026-02-25T10:00:03.216716Z","steps":["trace[1309658265] 'process raft request' (duration: 296.17977ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:00:03.216629Z","caller":"traceutil/trace.go:171","msg":"trace[124071176] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:354; }","duration":"452.004842ms","start":"2026-02-25T10:00:02.764599Z","end":"2026-02-25T10:00:03.216604Z","steps":["trace[124071176] 'agreement among raft nodes before linearized reading' (duration: 451.699307ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:03.217077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:02.764585Z","time spent":"452.479555ms","remote":"127.0.0.1:33806","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-02-25T10:00:03.216532Z","caller":"traceutil/trace.go:171","msg":"trace[439348226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:354; }","duration":"519.4616ms","start":"2026-02-25T10:00:02.697053Z","end":"2026-02-25T10:00:03.216514Z","steps":["trace[439348226] 'agreement among raft nodes before linearized reading' (duration: 519.233219ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:03.217308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:02.697018Z","time spent":"520.281902ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T10:00:03.216795Z","caller":"traceutil/trace.go:171","msg":"trace[483751760] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:354; }","duration":"567.527332ms","start":"2026-02-25T10:00:02.649254Z","end":"2026-02-25T10:00:03.216782Z","steps":["trace[483751760] 'agreement among raft nodes before linearized reading' (duration: 566.86548ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:03.217507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:02.649217Z","time spent":"568.28153ms","remote":"127.0.0.1:33806","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-02-25T10:00:03.95195Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184256795271196209,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T10:00:04.177394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.148222ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T10:00:04.177538Z","caller":"traceutil/trace.go:171","msg":"trace[794339994] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"954.41421ms","start":"2026-02-25T10:00:03.223107Z","end":"2026-02-25T10:00:04.177521Z","steps":["trace[794339994] 'process raft request' (duration: 143.89778ms)","trace[794339994] 'compare' (duration: 810.008145ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:04.177585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:03.223076Z","time spent":"954.490193ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:04.179652Z","caller":"traceutil/trace.go:171","msg":"trace[707908062] linearizableReadLoop","detail":"{readStateIndex:367; appliedIndex:364; }","duration":"728.412804ms","start":"2026-02-25T10:00:03.451197Z","end":"2026-02-25T10:00:04.17961Z","steps":["trace[707908062] 'read index received' (duration: 728.252596ms)","trace[707908062] 'applied index is now lower than readState.Index' (duration: 159.488µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:04.179743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.54071ms","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-02-25T10:00:04.179769Z","caller":"traceutil/trace.go:171","msg":"trace[992032406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:358; }","duration":"728.595043ms","start":"2026-02-25T10:00:03.451165Z","end":"2026-02-25T10:00:04.17976Z","steps":["trace[992032406] 'agreement among raft nodes before linearized reading' (duration: 728.52376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:04.17979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:03.451148Z","time spent":"728.636524ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T10:00:04.179953Z","caller":"traceutil/trace.go:171","msg":"trace[1296975238] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"956.588897ms","start":"2026-02-25T10:00:03.223289Z","end":"2026-02-25T10:00:04.179878Z","steps":["trace[1296975238] 'process raft request' (duration: 956.272051ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:04.18019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:03.223281Z","time spent":"956.794377ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:04.180011Z","caller":"traceutil/trace.go:171","msg":"trace[802518574] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"951.152216ms","start":"2026-02-25T10:00:03.228846Z","end":"2026-02-25T10:00:04.179999Z","steps":["trace[802518574] 'process raft request' (duration: 950.732995ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:00:04.180274Z","caller":"traceutil/trace.go:171","msg":"trace[573944467] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"956.996286ms","start":"2026-02-25T10:00:03.223237Z","end":"2026-02-25T10:00:04.180233Z","steps":["trace[573944467] 'process raft request' (duration: 956.25998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:04.180404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:03.228833Z","time spent":"951.507373ms","remote":"127.0.0.1:33710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T10:00:04.180469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:03.223194Z","time spent":"957.178216ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:08.967459Z","caller":"traceutil/trace.go:171","msg":"trace[608670220] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"131.321667ms","start":"2026-02-25T10:00:08.836117Z","end":"2026-02-25T10:00:08.967438Z","steps":["trace[608670220] 'process raft request' (duration: 131.17098ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:10.092575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.111445299s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4260"} {"level":"info","ts":"2026-02-25T10:00:10.092666Z","caller":"traceutil/trace.go:171","msg":"trace[1422807557] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:373; }","duration":"1.111555114s","start":"2026-02-25T10:00:08.981093Z","end":"2026-02-25T10:00:10.092648Z","steps":["trace[1422807557] 'range keys from in-memory index tree' (duration: 1.111346034s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:10.092701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:08.981053Z","time spent":"1.111641568s","remote":"127.0.0.1:33710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4282,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-25T10:00:10.092628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"959.46964ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T10:00:10.092761Z","caller":"traceutil/trace.go:171","msg":"trace[970684739] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:373; }","duration":"959.633807ms","start":"2026-02-25T10:00:09.133108Z","end":"2026-02-25T10:00:10.092741Z","steps":["trace[970684739] 'range keys from in-memory index tree' (duration: 959.349034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:10.092575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"919.122397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-25T10:00:10.092819Z","caller":"traceutil/trace.go:171","msg":"trace[362372525] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:373; }","duration":"919.441361ms","start":"2026-02-25T10:00:09.173358Z","end":"2026-02-25T10:00:10.0928Z","steps":["trace[362372525] 'range keys from in-memory index tree' (duration: 918.97108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:10.092867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:09.173333Z","time spent":"919.521615ms","remote":"127.0.0.1:33994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4056,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-25T10:00:14.74627Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184256795271196323,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T10:00:15.105921Z","caller":"traceutil/trace.go:171","msg":"trace[1853159870] linearizableReadLoop","detail":"{readStateIndex:427; appliedIndex:426; }","duration":"860.302619ms","start":"2026-02-25T10:00:14.245579Z","end":"2026-02-25T10:00:15.105881Z","steps":["trace[1853159870] 'read index received' (duration: 860.051049ms)","trace[1853159870] 'applied index is now lower than readState.Index' (duration: 250.25µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:00:15.106079Z","caller":"traceutil/trace.go:171","msg":"trace[1861588035] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"862.470252ms","start":"2026-02-25T10:00:14.243595Z","end":"2026-02-25T10:00:15.106065Z","steps":["trace[1861588035] 'process raft request' (duration: 862.100906ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.106218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:14.243574Z","time spent":"862.540276ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T10:00:15.106341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.682946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-25T10:00:15.106406Z","caller":"traceutil/trace.go:171","msg":"trace[216104070] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:414; }","duration":"860.800052ms","start":"2026-02-25T10:00:14.245588Z","end":"2026-02-25T10:00:15.106388Z","steps":["trace[216104070] 'agreement among raft nodes before linearized reading' (duration: 860.692557ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.106447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:14.24556Z","time spent":"860.876405ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T10:00:15.106597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"861.028251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-02-25T10:00:15.106637Z","caller":"traceutil/trace.go:171","msg":"trace[255204413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"861.107745ms","start":"2026-02-25T10:00:14.245517Z","end":"2026-02-25T10:00:15.106624Z","steps":["trace[255204413] 'agreement among raft nodes before linearized reading' (duration: 861.035242ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.106663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.021399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.102\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-25T10:00:15.106718Z","caller":"traceutil/trace.go:171","msg":"trace[803718182] range","detail":"{range_begin:/registry/masterleases/199.204.45.102; range_end:; response_count:1; response_revision:414; }","duration":"846.097082ms","start":"2026-02-25T10:00:14.260604Z","end":"2026-02-25T10:00:15.106701Z","steps":["trace[803718182] 'agreement among raft nodes before linearized reading' (duration: 845.999208ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.106795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:14.260593Z","time spent":"846.190626ms","remote":"127.0.0.1:35918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.102\" "} {"level":"warn","ts":"2026-02-25T10:00:15.106873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.315663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-25T10:00:15.106916Z","caller":"traceutil/trace.go:171","msg":"trace[246061786] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:414; }","duration":"855.406787ms","start":"2026-02-25T10:00:14.251497Z","end":"2026-02-25T10:00:15.106903Z","steps":["trace[246061786] 'agreement among raft nodes before linearized reading' (duration: 855.199318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.106953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:14.251482Z","time spent":"855.460868ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-25T10:00:15.106672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:14.245479Z","time spent":"861.183067ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T10:00:15.107141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.839023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T10:00:15.107183Z","caller":"traceutil/trace.go:171","msg":"trace[1590463366] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:414; }","duration":"837.896786ms","start":"2026-02-25T10:00:14.26927Z","end":"2026-02-25T10:00:15.107167Z","steps":["trace[1590463366] 'agreement among raft nodes before linearized reading' (duration: 837.840264ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.107265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:14.26926Z","time spent":"837.948958ms","remote":"127.0.0.1:35872","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-25T10:00:15.539162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:15.108111Z","time spent":"431.041224ms","remote":"127.0.0.1:35918","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-02-25T10:00:15.783466Z","caller":"traceutil/trace.go:171","msg":"trace[1836035228] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"671.469022ms","start":"2026-02-25T10:00:15.111953Z","end":"2026-02-25T10:00:15.783422Z","steps":["trace[1836035228] 'process raft request' (duration: 665.322489ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.783677Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:15.111929Z","time spent":"671.638219ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:15.784073Z","caller":"traceutil/trace.go:171","msg":"trace[870390675] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"671.415972ms","start":"2026-02-25T10:00:15.11265Z","end":"2026-02-25T10:00:15.784066Z","steps":["trace[870390675] 'process raft request' (duration: 671.126878ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:00:15.784053Z","caller":"traceutil/trace.go:171","msg":"trace[1507857388] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"671.491624ms","start":"2026-02-25T10:00:15.112534Z","end":"2026-02-25T10:00:15.784026Z","steps":["trace[1507857388] 'process raft request' (duration: 670.737212ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.784123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:15.112641Z","time spent":"671.454303ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T10:00:15.784227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:15.112519Z","time spent":"671.608929ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:15.784308Z","caller":"traceutil/trace.go:171","msg":"trace[1746846047] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:427; }","duration":"513.378755ms","start":"2026-02-25T10:00:15.270919Z","end":"2026-02-25T10:00:15.784298Z","steps":["trace[1746846047] 'read index received' (duration: 252.352801ms)","trace[1746846047] 'applied index is now lower than readState.Index' (duration: 261.024364ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:15.784375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.464058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T10:00:15.784394Z","caller":"traceutil/trace.go:171","msg":"trace[1068464166] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:417; }","duration":"513.548252ms","start":"2026-02-25T10:00:15.270839Z","end":"2026-02-25T10:00:15.784387Z","steps":["trace[1068464166] 'agreement among raft nodes before linearized reading' (duration: 513.48741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:15.784411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:15.270815Z","time spent":"513.592694ms","remote":"127.0.0.1:35872","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-02-25T10:00:15.784702Z","caller":"traceutil/trace.go:171","msg":"trace[607896275] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"242.967299ms","start":"2026-02-25T10:00:15.541704Z","end":"2026-02-25T10:00:15.784671Z","steps":["trace[607896275] 'process raft request' (duration: 242.859685ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:00:25.272559Z","caller":"traceutil/trace.go:171","msg":"trace[212228036] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"107.283654ms","start":"2026-02-25T10:00:25.16524Z","end":"2026-02-25T10:00:25.272524Z","steps":["trace[212228036] 'process raft request' (duration: 107.033673ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:26.334462Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184256795271196462,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T10:00:26.835773Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184256795271196462,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T10:00:27.335912Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184256795271196462,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-25T10:00:27.346569Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.583229854s","expected-duration":"1s"} {"level":"info","ts":"2026-02-25T10:00:27.347227Z","caller":"traceutil/trace.go:171","msg":"trace[1062513844] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"1.584028153s","start":"2026-02-25T10:00:25.763166Z","end":"2026-02-25T10:00:27.347194Z","steps":["trace[1062513844] 'process raft request' (duration: 1.583775094s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:27.347413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:25.763141Z","time spent":"1.584166249s","remote":"127.0.0.1:33706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4258,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T10:00:27.906875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.821678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T10:00:27.907001Z","caller":"traceutil/trace.go:171","msg":"trace[167989476] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:489; }","duration":"2.073732833s","start":"2026-02-25T10:00:25.83325Z","end":"2026-02-25T10:00:27.906983Z","steps":["trace[167989476] 'read index received' (duration: 1.51379389s)","trace[167989476] 'applied index is now lower than readState.Index' (duration: 559.937693ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:00:27.907071Z","caller":"traceutil/trace.go:171","msg":"trace[209700234] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"1.463284681s","start":"2026-02-25T10:00:26.443747Z","end":"2026-02-25T10:00:27.907032Z","steps":["trace[209700234] 'process raft request' (duration: 1.077199523s)","trace[209700234] 'compare' (duration: 385.05202ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:27.907212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.073964581s","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-02-25T10:00:27.907192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.073907449s","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-02-25T10:00:27.907249Z","caller":"traceutil/trace.go:171","msg":"trace[368498858] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:475; }","duration":"2.074045434s","start":"2026-02-25T10:00:25.833191Z","end":"2026-02-25T10:00:27.907237Z","steps":["trace[368498858] 'agreement among raft nodes before linearized reading' (duration: 2.073883448s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:27.90726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:26.443713Z","time spent":"1.463445206s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:27.907278Z","caller":"traceutil/trace.go:171","msg":"trace[194600102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:475; }","duration":"2.074050285s","start":"2026-02-25T10:00:25.833205Z","end":"2026-02-25T10:00:27.907256Z","steps":["trace[194600102] 'agreement among raft nodes before linearized reading' (duration: 2.073843747s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:27.907288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:25.833154Z","time spent":"2.074122498s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-25T10:00:27.907381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:25.833181Z","time spent":"2.074134268s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-25T10:00:27.907537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.613201ms","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-02-25T10:00:27.90757Z","caller":"traceutil/trace.go:171","msg":"trace[1002747664] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:475; }","duration":"630.706174ms","start":"2026-02-25T10:00:27.276856Z","end":"2026-02-25T10:00:27.907562Z","steps":["trace[1002747664] 'agreement among raft nodes before linearized reading' (duration: 630.649512ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:27.907597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:27.276827Z","time spent":"630.764366ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-25T10:00:27.907626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.071096162s","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-02-25T10:00:27.907676Z","caller":"traceutil/trace.go:171","msg":"trace[1894768646] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:475; }","duration":"2.071171875s","start":"2026-02-25T10:00:25.83649Z","end":"2026-02-25T10:00:27.907661Z","steps":["trace[1894768646] 'agreement among raft nodes before linearized reading' (duration: 2.070983138s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:27.907712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.637584888s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T10:00:27.907717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:25.836473Z","time spent":"2.071236598s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T10:00:27.90775Z","caller":"traceutil/trace.go:171","msg":"trace[35292559] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:475; }","duration":"1.637618549s","start":"2026-02-25T10:00:26.270119Z","end":"2026-02-25T10:00:27.907737Z","steps":["trace[35292559] 'agreement among raft nodes before linearized reading' (duration: 1.637565307s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:27.907794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:26.270056Z","time spent":"1.637730503s","remote":"127.0.0.1:35872","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-02-25T10:00:34.374497Z","caller":"traceutil/trace.go:171","msg":"trace[1577427074] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"112.632547ms","start":"2026-02-25T10:00:34.261838Z","end":"2026-02-25T10:00:34.37447Z","steps":["trace[1577427074] 'read index received' (duration: 112.461552ms)","trace[1577427074] 'applied index is now lower than readState.Index' (duration: 170.465µs)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:34.374639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.790633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.102\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-02-25T10:00:34.374662Z","caller":"traceutil/trace.go:171","msg":"trace[872431033] range","detail":"{range_begin:/registry/masterleases/199.204.45.102; range_end:; response_count:1; response_revision:518; }","duration":"112.889427ms","start":"2026-02-25T10:00:34.261765Z","end":"2026-02-25T10:00:34.374655Z","steps":["trace[872431033] 'agreement among raft nodes before linearized reading' (duration: 112.822724ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:00:34.374616Z","caller":"traceutil/trace.go:171","msg":"trace[1451602519] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"237.108231ms","start":"2026-02-25T10:00:34.137457Z","end":"2026-02-25T10:00:34.374565Z","steps":["trace[1451602519] 'process raft request' (duration: 236.859592ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:00:36.547209Z","caller":"traceutil/trace.go:171","msg":"trace[766965360] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"569.943814ms","start":"2026-02-25T10:00:35.977183Z","end":"2026-02-25T10:00:36.547127Z","steps":["trace[766965360] 'process raft request' (duration: 569.779629ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:36.547389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:35.977169Z","time spent":"570.13243ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T10:00:37.887171Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.340216535s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-25T10:00:38.096152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.530582ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T10:00:38.096253Z","caller":"traceutil/trace.go:171","msg":"trace[20878639] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:520; }","duration":"893.657186ms","start":"2026-02-25T10:00:37.202583Z","end":"2026-02-25T10:00:38.09624Z","steps":["trace[20878639] 'range keys from in-memory index tree' (duration: 893.512241ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:38.096741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.105908ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-25T10:00:38.096871Z","caller":"traceutil/trace.go:171","msg":"trace[1909732375] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:537; }","duration":"1.825924579s","start":"2026-02-25T10:00:36.270939Z","end":"2026-02-25T10:00:38.096864Z","steps":["trace[1909732375] 'read index received' (duration: 276.054657ms)","trace[1909732375] 'applied index is now lower than readState.Index' (duration: 1.549869452s)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:38.096909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.82598193s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T10:00:38.09692Z","caller":"traceutil/trace.go:171","msg":"trace[1437499097] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:523; }","duration":"1.826027963s","start":"2026-02-25T10:00:36.270888Z","end":"2026-02-25T10:00:38.096916Z","steps":["trace[1437499097] 'agreement among raft nodes before linearized reading' (duration: 1.825995682s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:38.096946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:36.270869Z","time spent":"1.826073153s","remote":"127.0.0.1:35872","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-02-25T10:00:38.097142Z","caller":"traceutil/trace.go:171","msg":"trace[602982876] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"2.11993718s","start":"2026-02-25T10:00:35.977198Z","end":"2026-02-25T10:00:38.097135Z","steps":["trace[602982876] 'process raft request' (duration: 1.910427248s)","trace[602982876] 'compare' (duration: 208.698895ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:00:38.097183Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:35.977167Z","time spent":"2.119995292s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:38.097243Z","caller":"traceutil/trace.go:171","msg":"trace[646879874] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"2.119248387s","start":"2026-02-25T10:00:35.97799Z","end":"2026-02-25T10:00:38.097238Z","steps":["trace[646879874] 'process raft request' (duration: 2.118802443s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:38.097265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:35.977958Z","time spent":"2.119294139s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:38.09732Z","caller":"traceutil/trace.go:171","msg":"trace[1155094239] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"2.119142223s","start":"2026-02-25T10:00:35.978174Z","end":"2026-02-25T10:00:38.097316Z","steps":["trace[1155094239] 'process raft request' (duration: 2.118670847s)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:00:38.097342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:00:35.978166Z","time spent":"2.119163005s","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:00:40.527395Z","caller":"traceutil/trace.go:171","msg":"trace[669873786] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"213.441356ms","start":"2026-02-25T10:00:40.313928Z","end":"2026-02-25T10:00:40.527369Z","steps":["trace[669873786] 'process raft request' (duration: 190.700606ms)","trace[669873786] 'compare' (duration: 22.435261ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:00:42.52609Z","caller":"traceutil/trace.go:171","msg":"trace[607163643] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"186.946465ms","start":"2026-02-25T10:00:42.338802Z","end":"2026-02-25T10:00:42.525748Z","steps":["trace[607163643] 'process raft request' (duration: 186.753329ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:01:56.812385Z","caller":"traceutil/trace.go:171","msg":"trace[1554467658] transaction","detail":"{read_only:false; response_revision:894; number_of_response:1; }","duration":"166.281313ms","start":"2026-02-25T10:01:56.646083Z","end":"2026-02-25T10:01:56.812365Z","steps":["trace[1554467658] 'process raft request' (duration: 125.274325ms)","trace[1554467658] 'compare' (duration: 40.826435ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:01:56.838474Z","caller":"traceutil/trace.go:171","msg":"trace[1937254225] linearizableReadLoop","detail":"{readStateIndex:930; appliedIndex:928; }","duration":"132.053677ms","start":"2026-02-25T10:01:56.706384Z","end":"2026-02-25T10:01:56.838438Z","steps":["trace[1937254225] 'read index received' (duration: 64.984437ms)","trace[1937254225] 'applied index is now lower than readState.Index' (duration: 67.06777ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:01:56.83865Z","caller":"traceutil/trace.go:171","msg":"trace[1495591524] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"191.969959ms","start":"2026-02-25T10:01:56.646581Z","end":"2026-02-25T10:01:56.838551Z","steps":["trace[1495591524] 'process raft request' (duration: 191.597032ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:01:56.838696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.283341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-25T10:01:56.838786Z","caller":"traceutil/trace.go:171","msg":"trace[933005249] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:895; }","duration":"132.432904ms","start":"2026-02-25T10:01:56.706336Z","end":"2026-02-25T10:01:56.838769Z","steps":["trace[933005249] 'agreement among raft nodes before linearized reading' (duration: 132.280011ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:01:57.768358Z","caller":"traceutil/trace.go:171","msg":"trace[873537600] transaction","detail":"{read_only:false; response_revision:902; number_of_response:1; }","duration":"104.057472ms","start":"2026-02-25T10:01:57.66427Z","end":"2026-02-25T10:01:57.768327Z","steps":["trace[873537600] 'process raft request' (duration: 94.440264ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:01:57.896695Z","caller":"traceutil/trace.go:171","msg":"trace[850004865] transaction","detail":"{read_only:false; response_revision:903; number_of_response:1; }","duration":"124.387825ms","start":"2026-02-25T10:01:57.772279Z","end":"2026-02-25T10:01:57.896667Z","steps":["trace[850004865] 'process raft request' (duration: 106.828877ms)","trace[850004865] 'compare' (duration: 17.310164ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:01:57.896638Z","caller":"traceutil/trace.go:171","msg":"trace[1630787693] linearizableReadLoop","detail":"{readStateIndex:940; appliedIndex:938; }","duration":"117.730816ms","start":"2026-02-25T10:01:57.778875Z","end":"2026-02-25T10:01:57.896606Z","steps":["trace[1630787693] 'read index received' (duration: 100.236729ms)","trace[1630787693] 'applied index is now lower than readState.Index' (duration: 17.492977ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:01:57.896711Z","caller":"traceutil/trace.go:171","msg":"trace[2097466388] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"118.404478ms","start":"2026-02-25T10:01:57.778288Z","end":"2026-02-25T10:01:57.896693Z","steps":["trace[2097466388] 'process raft request' (duration: 118.273126ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:01:57.896919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.000141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/local-path-storage/\" range_end:\"/registry/limitranges/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T10:01:57.89702Z","caller":"traceutil/trace.go:171","msg":"trace[861568533] range","detail":"{range_begin:/registry/limitranges/local-path-storage/; range_end:/registry/limitranges/local-path-storage0; response_count:0; response_revision:904; }","duration":"118.137304ms","start":"2026-02-25T10:01:57.778856Z","end":"2026-02-25T10:01:57.896993Z","steps":["trace[861568533] 'agreement among raft nodes before linearized reading' (duration: 117.92917ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:01:58.775911Z","caller":"traceutil/trace.go:171","msg":"trace[1988811760] transaction","detail":"{read_only:false; response_revision:907; number_of_response:1; }","duration":"166.667984ms","start":"2026-02-25T10:01:58.609213Z","end":"2026-02-25T10:01:58.775881Z","steps":["trace[1988811760] 'process raft request' (duration: 166.533832ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:01:58.921533Z","caller":"traceutil/trace.go:171","msg":"trace[1545376164] transaction","detail":"{read_only:false; response_revision:908; number_of_response:1; }","duration":"100.975291ms","start":"2026-02-25T10:01:58.820518Z","end":"2026-02-25T10:01:58.921493Z","steps":["trace[1545376164] 'process raft request' (duration: 31.428164ms)","trace[1545376164] 'compare' (duration: 69.235872ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:01:59.079544Z","caller":"traceutil/trace.go:171","msg":"trace[1218284303] transaction","detail":"{read_only:false; response_revision:911; number_of_response:1; }","duration":"145.019673ms","start":"2026-02-25T10:01:58.934472Z","end":"2026-02-25T10:01:59.079492Z","steps":["trace[1218284303] 'process raft request' (duration: 114.195053ms)","trace[1218284303] 'compare' (duration: 30.373802ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:01:59.996699Z","caller":"traceutil/trace.go:171","msg":"trace[324728505] transaction","detail":"{read_only:false; response_revision:916; number_of_response:1; }","duration":"120.136822ms","start":"2026-02-25T10:01:59.876542Z","end":"2026-02-25T10:01:59.996679Z","steps":["trace[324728505] 'process raft request' (duration: 120.01641ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:02:01.093567Z","caller":"traceutil/trace.go:171","msg":"trace[255017932] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"120.187681ms","start":"2026-02-25T10:02:00.973351Z","end":"2026-02-25T10:02:01.093539Z","steps":["trace[255017932] 'process raft request' (duration: 101.873468ms)","trace[255017932] 'compare' (duration: 18.034089ms)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:02:03.016587Z","caller":"traceutil/trace.go:171","msg":"trace[1991047695] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"114.220681ms","start":"2026-02-25T10:02:02.902334Z","end":"2026-02-25T10:02:03.016555Z","steps":["trace[1991047695] 'read index received' (duration: 113.965137ms)","trace[1991047695] 'applied index is now lower than readState.Index' (duration: 253.804µs)"],"step_count":2} {"level":"info","ts":"2026-02-25T10:02:03.016641Z","caller":"traceutil/trace.go:171","msg":"trace[947705061] transaction","detail":"{read_only:false; response_revision:922; number_of_response:1; }","duration":"153.948505ms","start":"2026-02-25T10:02:02.862666Z","end":"2026-02-25T10:02:03.016615Z","steps":["trace[947705061] 'process raft request' (duration: 153.64812ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:02:03.016789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.420854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-25T10:02:03.016919Z","caller":"traceutil/trace.go:171","msg":"trace[1347072747] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:922; }","duration":"114.526415ms","start":"2026-02-25T10:02:02.902323Z","end":"2026-02-25T10:02:03.016849Z","steps":["trace[1347072747] 'agreement among raft nodes before linearized reading' (duration: 114.372713ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:02:03.2792Z","caller":"traceutil/trace.go:171","msg":"trace[658049508] transaction","detail":"{read_only:false; response_revision:925; number_of_response:1; }","duration":"113.384398ms","start":"2026-02-25T10:02:03.165783Z","end":"2026-02-25T10:02:03.279167Z","steps":["trace[658049508] 'process raft request' (duration: 112.994432ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:02:09.67429Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":184256795271197608,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-25T10:02:09.805232Z","caller":"traceutil/trace.go:171","msg":"trace[1783281705] transaction","detail":"{read_only:false; response_revision:959; number_of_response:1; }","duration":"669.922906ms","start":"2026-02-25T10:02:09.135284Z","end":"2026-02-25T10:02:09.805207Z","steps":["trace[1783281705] 'process raft request' (duration: 661.242384ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:02:09.805359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:02:09.135273Z","time spent":"670.024558ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:02:09.809801Z","caller":"traceutil/trace.go:171","msg":"trace[598803803] linearizableReadLoop","detail":"{readStateIndex:998; appliedIndex:996; }","duration":"640.437156ms","start":"2026-02-25T10:02:09.169342Z","end":"2026-02-25T10:02:09.809779Z","steps":["trace[598803803] 'read index received' (duration: 627.204373ms)","trace[598803803] 'applied index is now lower than readState.Index' (duration: 13.231543ms)"],"step_count":2} {"level":"warn","ts":"2026-02-25T10:02:09.810025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.549055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-25T10:02:09.810019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.660959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-25T10:02:09.810056Z","caller":"traceutil/trace.go:171","msg":"trace[2129364357] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:959; }","duration":"538.711678ms","start":"2026-02-25T10:02:09.271336Z","end":"2026-02-25T10:02:09.810047Z","steps":["trace[2129364357] 'agreement among raft nodes before linearized reading' (duration: 538.572346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:02:09.810082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:02:09.271318Z","time spent":"538.758868ms","remote":"127.0.0.1:35872","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-02-25T10:02:09.810085Z","caller":"traceutil/trace.go:171","msg":"trace[918776713] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:959; }","duration":"640.77131ms","start":"2026-02-25T10:02:09.169296Z","end":"2026-02-25T10:02:09.810068Z","steps":["trace[918776713] 'agreement among raft nodes before linearized reading' (duration: 640.567827ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:02:09.81009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.82252ms","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":"warn","ts":"2026-02-25T10:02:09.810096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.695868ms","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-02-25T10:02:09.81012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:02:09.169273Z","time spent":"640.840272ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-25T10:02:09.810123Z","caller":"traceutil/trace.go:171","msg":"trace[1725048355] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:959; }","duration":"493.898051ms","start":"2026-02-25T10:02:09.316215Z","end":"2026-02-25T10:02:09.810113Z","steps":["trace[1725048355] 'agreement among raft nodes before linearized reading' (duration: 493.771099ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:02:09.81014Z","caller":"traceutil/trace.go:171","msg":"trace[2105448049] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:959; }","duration":"446.80495ms","start":"2026-02-25T10:02:09.363323Z","end":"2026-02-25T10:02:09.810128Z","steps":["trace[2105448049] 'agreement among raft nodes before linearized reading' (duration: 446.617407ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:02:09.810147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:02:09.316195Z","time spent":"493.947232ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-25T10:02:09.81017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:02:09.363294Z","time spent":"446.869782ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-25T10:02:16.269416Z","caller":"traceutil/trace.go:171","msg":"trace[1550031819] transaction","detail":"{read_only:false; response_revision:984; number_of_response:1; }","duration":"381.566751ms","start":"2026-02-25T10:02:15.887837Z","end":"2026-02-25T10:02:16.269404Z","steps":["trace[1550031819] 'process raft request' (duration: 381.343278ms)"],"step_count":1} {"level":"info","ts":"2026-02-25T10:02:16.269382Z","caller":"traceutil/trace.go:171","msg":"trace[126635476] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"381.508911ms","start":"2026-02-25T10:02:15.887848Z","end":"2026-02-25T10:02:16.269357Z","steps":["trace[126635476] 'process raft request' (duration: 381.46471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-25T10:02:16.269509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:02:15.88782Z","time spent":"381.634542ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-25T10:02:16.26952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-25T10:02:15.887821Z","time spent":"381.635592ms","remote":"127.0.0.1:33806","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-25T10:02:16.272148Z","caller":"traceutil/trace.go:171","msg":"trace[304349804] transaction","detail":"{read_only:false; response_revision:986; number_of_response:1; }","duration":"263.941789ms","start":"2026-02-25T10:02:16.008182Z","end":"2026-02-25T10:02:16.272124Z","steps":["trace[304349804] 'process raft request' (duration: 263.832418ms)"],"step_count":1}