{"level":"warn","ts":"2026-04-15T03:10:35.129284Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T03:10:35.129381Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53: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.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-15T03:10:35.129459Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-15T03:10:35.129474Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-15T03:10:35.129648Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-15T03:10:35.133002Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-04-15T03:10:35.133157Z","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.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-15T03:10:35.137457Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.767321ms"} {"level":"info","ts":"2026-04-15T03:10:35.152008Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-04-15T03:10:35.152164Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-04-15T03:10:35.152204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-04-15T03:10:35.152218Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-15T03:10:35.152238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-04-15T03:10:35.152285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-04-15T03:10:35.17643Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-15T03:10:35.181886Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-15T03:10:35.183743Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-15T03:10:35.186999Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-15T03:10:35.187087Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-15T03:10:35.187404Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T03:10:35.187497Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T03:10:35.187511Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-15T03:10:35.188088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-04-15T03:10:35.188208Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-04-15T03:10:35.190803Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-15T03:10:35.190912Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-15T03:10:35.190949Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-04-15T03:10:35.191245Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-15T03:10:35.191296Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-15T03:10:36.152962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-04-15T03:10:36.153031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-04-15T03:10:36.153067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-04-15T03:10:36.153094Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-04-15T03:10:36.153106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-15T03:10:36.153123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-04-15T03:10:36.153138Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-04-15T03:10:36.154412Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T03:10:36.15573Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-04-15T03:10:36.15574Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T03:10:36.155826Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-15T03:10:36.156155Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-15T03:10:36.156227Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-15T03:10:36.157284Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T03:10:36.157507Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T03:10:36.157566Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-15T03:10:36.159577Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-04-15T03:10:36.160781Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-15T03:10:39.3466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.857941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T03:10:39.346729Z","caller":"traceutil/trace.go:171","msg":"trace[1717642934] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"235.866451ms","start":"2026-04-15T03:10:39.110845Z","end":"2026-04-15T03:10:39.346711Z","steps":["trace[1717642934] 'process raft request' (duration: 73.443409ms)","trace[1717642934] 'compare' (duration: 161.712087ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:10:39.347971Z","caller":"traceutil/trace.go:171","msg":"trace[352630425] transaction","detail":"{read_only:false; response_revision:200; number_of_response:1; }","duration":"168.936501ms","start":"2026-04-15T03:10:39.179021Z","end":"2026-04-15T03:10:39.347957Z","steps":["trace[352630425] 'process raft request' (duration: 168.878389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:40.438358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.317383ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T03:10:40.438461Z","caller":"traceutil/trace.go:171","msg":"trace[534244065] linearizableReadLoop","detail":"{readStateIndex:206; appliedIndex:205; }","duration":"906.839053ms","start":"2026-04-15T03:10:39.531605Z","end":"2026-04-15T03:10:40.438444Z","steps":["trace[534244065] 'read index received' (duration: 47.161µs)","trace[534244065] 'applied index is now lower than readState.Index' (duration: 906.790852ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:10:40.438494Z","caller":"traceutil/trace.go:171","msg":"trace[1854490061] transaction","detail":"{read_only:false; response_revision:201; number_of_response:1; }","duration":"1.086380605s","start":"2026-04-15T03:10:39.352088Z","end":"2026-04-15T03:10:40.438468Z","steps":["trace[1854490061] 'process raft request' (duration: 94.890499ms)","trace[1854490061] 'compare' (duration: 991.178749ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T03:10:40.438623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.011326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-15T03:10:40.438698Z","caller":"traceutil/trace.go:171","msg":"trace[1827167222] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:201; }","duration":"907.130729ms","start":"2026-04-15T03:10:39.531546Z","end":"2026-04-15T03:10:40.438677Z","steps":["trace[1827167222] 'agreement among raft nodes before linearized reading' (duration: 906.959805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:40.438637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:39.352064Z","time spent":"1.086490138s","remote":"127.0.0.1:56524","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":342,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T03:10:40.438717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.047401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-15T03:10:40.438728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:39.531524Z","time spent":"907.19811ms","remote":"127.0.0.1:56464","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":"info","ts":"2026-04-15T03:10:40.438782Z","caller":"traceutil/trace.go:171","msg":"trace[774465966] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:201; }","duration":"491.138193ms","start":"2026-04-15T03:10:39.947611Z","end":"2026-04-15T03:10:40.438749Z","steps":["trace[774465966] 'agreement among raft nodes before linearized reading' (duration: 491.048221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:40.438824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:39.947587Z","time spent":"491.229015ms","remote":"127.0.0.1:56464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":29,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T03:10:41.331922Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5794898583560163827,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-15T03:10:41.550455Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.108009838s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-15T03:10:42.023547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.754015ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T03:10:42.02364Z","caller":"traceutil/trace.go:171","msg":"trace[167004762] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"1.581248724s","start":"2026-04-15T03:10:40.442374Z","end":"2026-04-15T03:10:42.023623Z","steps":["trace[167004762] 'process raft request' (duration: 1.108333475s)","trace[167004762] 'compare' (duration: 472.267354ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T03:10:42.023692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:40.442354Z","time spent":"1.581318116s","remote":"127.0.0.1:56464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T03:10:42.031648Z","caller":"traceutil/trace.go:171","msg":"trace[1670809597] linearizableReadLoop","detail":"{readStateIndex:209; appliedIndex:206; }","duration":"1.199776782s","start":"2026-04-15T03:10:40.831844Z","end":"2026-04-15T03:10:42.031621Z","steps":["trace[1670809597] 'read index received' (duration: 718.861365ms)","trace[1670809597] 'applied index is now lower than readState.Index' (duration: 480.913987ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T03:10:42.031799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.199932477s","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-04-15T03:10:42.031852Z","caller":"traceutil/trace.go:171","msg":"trace[582192975] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:204; }","duration":"1.20004656s","start":"2026-04-15T03:10:40.83179Z","end":"2026-04-15T03:10:42.031836Z","steps":["trace[582192975] 'agreement among raft nodes before linearized reading' (duration: 1.199958347s)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:10:42.031825Z","caller":"traceutil/trace.go:171","msg":"trace[1882705898] transaction","detail":"{read_only:false; response_revision:204; number_of_response:1; }","duration":"1.58680687s","start":"2026-04-15T03:10:40.444938Z","end":"2026-04-15T03:10:42.031745Z","steps":["trace[1882705898] 'process raft request' (duration: 1.586605846s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:42.031907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:40.831772Z","time spent":"1.200123252s","remote":"127.0.0.1:56464","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":"info","ts":"2026-04-15T03:10:42.032227Z","caller":"traceutil/trace.go:171","msg":"trace[1593673945] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"1.586884062s","start":"2026-04-15T03:10:40.444869Z","end":"2026-04-15T03:10:42.031753Z","steps":["trace[1593673945] 'process raft request' (duration: 1.586547324s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:42.032495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:40.444924Z","time spent":"1.587014295s","remote":"127.0.0.1:56464","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T03:10:42.033181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:40.444847Z","time spent":"1.587489886s","remote":"127.0.0.1:56536","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T03:10:42.053504Z","caller":"traceutil/trace.go:171","msg":"trace[1976232203] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"430.533461ms","start":"2026-04-15T03:10:41.622953Z","end":"2026-04-15T03:10:42.053487Z","steps":["trace[1976232203] 'process raft request' (duration: 430.367277ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:42.0536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:41.622929Z","time spent":"430.626333ms","remote":"127.0.0.1:56378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T03:10:42.053661Z","caller":"traceutil/trace.go:171","msg":"trace[75757169] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"307.844089ms","start":"2026-04-15T03:10:41.74578Z","end":"2026-04-15T03:10:42.053624Z","steps":["trace[75757169] 'process raft request' (duration: 307.602024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:42.053779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:41.745729Z","time spent":"307.987732ms","remote":"127.0.0.1:56378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T03:10:42.054039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.667251ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T03:10:42.054093Z","caller":"traceutil/trace.go:171","msg":"trace[1447869424] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:206; }","duration":"531.750243ms","start":"2026-04-15T03:10:41.522325Z","end":"2026-04-15T03:10:42.054075Z","steps":["trace[1447869424] 'agreement among raft nodes before linearized reading' (duration: 531.684791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:10:42.054129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:10:41.522306Z","time spent":"531.816134ms","remote":"127.0.0.1:56464","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-04-15T03:11:04.935489Z","caller":"traceutil/trace.go:171","msg":"trace[1293777114] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"498.429465ms","start":"2026-04-15T03:11:04.437036Z","end":"2026-04-15T03:11:04.935466Z","steps":["trace[1293777114] 'process raft request' (duration: 498.236928ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.935623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.437013Z","time spent":"498.552609ms","remote":"127.0.0.1:56240","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-04-15T03:11:04.944636Z","caller":"traceutil/trace.go:171","msg":"trace[312553392] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"490.546616ms","start":"2026-04-15T03:11:04.454074Z","end":"2026-04-15T03:11:04.944621Z","steps":["trace[312553392] 'process raft request' (duration: 490.138814ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:04.944678Z","caller":"traceutil/trace.go:171","msg":"trace[1818946508] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"479.600115ms","start":"2026-04-15T03:11:04.465054Z","end":"2026-04-15T03:11:04.944654Z","steps":["trace[1818946508] 'process raft request' (duration: 479.248654ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.944714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.454051Z","time spent":"490.623398ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T03:11:04.944781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.465018Z","time spent":"479.715148ms","remote":"127.0.0.1:56240","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-04-15T03:11:04.944858Z","caller":"traceutil/trace.go:171","msg":"trace[397883145] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"493.63623ms","start":"2026-04-15T03:11:04.451215Z","end":"2026-04-15T03:11:04.944851Z","steps":["trace[397883145] 'process raft request' (duration: 492.945789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.944917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.451201Z","time spent":"493.699371ms","remote":"127.0.0.1:56240","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-04-15T03:11:04.944926Z","caller":"traceutil/trace.go:171","msg":"trace[2016407957] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"488.725321ms","start":"2026-04-15T03:11:04.456179Z","end":"2026-04-15T03:11:04.944904Z","steps":["trace[2016407957] 'process raft request' (duration: 488.065832ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.944977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.456151Z","time spent":"488.801504ms","remote":"127.0.0.1:56240","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-04-15T03:11:04.944999Z","caller":"traceutil/trace.go:171","msg":"trace[424789362] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"493.724622ms","start":"2026-04-15T03:11:04.451267Z","end":"2026-04-15T03:11:04.944992Z","steps":["trace[424789362] 'process raft request' (duration: 492.918088ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.945033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.451264Z","time spent":"493.754444ms","remote":"127.0.0.1:56240","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-04-15T03:11:04.944982Z","caller":"traceutil/trace.go:171","msg":"trace[1293074068] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"342.310776ms","start":"2026-04-15T03:11:04.602536Z","end":"2026-04-15T03:11:04.944847Z","steps":["trace[1293074068] 'process raft request' (duration: 341.849793ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:04.945235Z","caller":"traceutil/trace.go:171","msg":"trace[1883859607] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"497.603ms","start":"2026-04-15T03:11:04.447218Z","end":"2026-04-15T03:11:04.944821Z","steps":["trace[1883859607] 'process raft request' (duration: 496.9196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.945238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.602507Z","time spent":"342.661018ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T03:11:04.945325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.4472Z","time spent":"498.097876ms","remote":"127.0.0.1:56240","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-04-15T03:11:04.945098Z","caller":"traceutil/trace.go:171","msg":"trace[43569652] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"488.885666ms","start":"2026-04-15T03:11:04.456205Z","end":"2026-04-15T03:11:04.945091Z","steps":["trace[43569652] 'process raft request' (duration: 488.066311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.945432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.456198Z","time spent":"489.209847ms","remote":"127.0.0.1:56240","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-04-15T03:11:04.945102Z","caller":"traceutil/trace.go:171","msg":"trace[124748176] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"461.239059ms","start":"2026-04-15T03:11:04.483856Z","end":"2026-04-15T03:11:04.945095Z","steps":["trace[124748176] 'process raft request' (duration: 460.485267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.94551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.483837Z","time spent":"461.660473ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T03:11:04.945003Z","caller":"traceutil/trace.go:171","msg":"trace[1382176391] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"507.420677ms","start":"2026-04-15T03:11:04.437559Z","end":"2026-04-15T03:11:04.94498Z","steps":["trace[1382176391] 'process raft request' (duration: 506.468589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.94557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.437532Z","time spent":"508.026047ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-15T03:11:04.94513Z","caller":"traceutil/trace.go:171","msg":"trace[1731994383] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"507.271704ms","start":"2026-04-15T03:11:04.437853Z","end":"2026-04-15T03:11:04.945124Z","steps":["trace[1731994383] 'process raft request' (duration: 506.255403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:04.945624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.437842Z","time spent":"507.771408ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T03:11:05.42514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.924567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-15T03:11:05.425254Z","caller":"traceutil/trace.go:171","msg":"trace[1599924992] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"440.683901ms","start":"2026-04-15T03:11:04.984551Z","end":"2026-04-15T03:11:05.425235Z","steps":["trace[1599924992] 'process raft request' (duration: 32.587849ms)","trace[1599924992] 'compare' (duration: 407.797033ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T03:11:05.425315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:04.983856Z","time spent":"441.430945ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T03:11:05.427949Z","caller":"traceutil/trace.go:171","msg":"trace[1009238133] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"425.08599ms","start":"2026-04-15T03:11:05.002783Z","end":"2026-04-15T03:11:05.427869Z","steps":["trace[1009238133] 'process raft request' (duration: 424.953496ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:05.428039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:05.002766Z","time spent":"425.229525ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T03:11:05.449613Z","caller":"traceutil/trace.go:171","msg":"trace[1239123041] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"426.63529ms","start":"2026-04-15T03:11:05.022958Z","end":"2026-04-15T03:11:05.449594Z","steps":["trace[1239123041] 'process raft request' (duration: 426.493786ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:05.449738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:05.022934Z","time spent":"426.736043ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T03:11:05.450058Z","caller":"traceutil/trace.go:171","msg":"trace[1504870108] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"413.289871ms","start":"2026-04-15T03:11:05.036756Z","end":"2026-04-15T03:11:05.450046Z","steps":["trace[1504870108] 'process raft request' (duration: 412.805097ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:05.450082Z","caller":"traceutil/trace.go:171","msg":"trace[1528078823] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"378.850927ms","start":"2026-04-15T03:11:05.071212Z","end":"2026-04-15T03:11:05.450063Z","steps":["trace[1528078823] 'process raft request' (duration: 378.771314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:05.450113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:05.036722Z","time spent":"413.367564ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T03:11:05.450189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:05.071194Z","time spent":"378.94005ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T03:11:05.450288Z","caller":"traceutil/trace.go:171","msg":"trace[157442162] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"406.679169ms","start":"2026-04-15T03:11:05.043558Z","end":"2026-04-15T03:11:05.450238Z","steps":["trace[157442162] 'process raft request' (duration: 406.309788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:05.450332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:05.043528Z","time spent":"406.780761ms","remote":"127.0.0.1:56240","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T03:11:10.916978Z","caller":"traceutil/trace.go:171","msg":"trace[869568647] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"269.591751ms","start":"2026-04-15T03:11:10.647332Z","end":"2026-04-15T03:11:10.916924Z","steps":["trace[869568647] 'process raft request' (duration: 170.318943ms)","trace[869568647] 'compare' (duration: 98.868865ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:11:11.780046Z","caller":"traceutil/trace.go:171","msg":"trace[1822104185] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:639; }","duration":"126.963119ms","start":"2026-04-15T03:11:11.653064Z","end":"2026-04-15T03:11:11.780028Z","steps":["trace[1822104185] 'read index received' (duration: 126.314549ms)","trace[1822104185] 'applied index is now lower than readState.Index' (duration: 647.71µs)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:11:11.780112Z","caller":"traceutil/trace.go:171","msg":"trace[1405212635] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"451.907137ms","start":"2026-04-15T03:11:11.328185Z","end":"2026-04-15T03:11:11.780093Z","steps":["trace[1405212635] 'process raft request' (duration: 451.457623ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:11.780204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.139824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-74gbx\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-15T03:11:11.780234Z","caller":"traceutil/trace.go:171","msg":"trace[741191208] range","detail":"{range_begin:/registry/pods/kube-system/cilium-74gbx; range_end:; response_count:1; response_revision:616; }","duration":"127.211767ms","start":"2026-04-15T03:11:11.653015Z","end":"2026-04-15T03:11:11.780227Z","steps":["trace[741191208] 'agreement among raft nodes before linearized reading' (duration: 127.078942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:11.780236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:11.328166Z","time spent":"451.998031ms","remote":"127.0.0.1:56306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-15T03:11:12.005142Z","caller":"traceutil/trace.go:171","msg":"trace[1584628001] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"210.487155ms","start":"2026-04-15T03:11:11.794632Z","end":"2026-04-15T03:11:12.005119Z","steps":["trace[1584628001] 'process raft request' (duration: 210.3377ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:13.598861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:13.179947Z","time spent":"418.903694ms","remote":"127.0.0.1:33278","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-15T03:11:13.599034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.538802413s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-15T03:11:13.599127Z","caller":"traceutil/trace.go:171","msg":"trace[1105050004] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"1.41304913s","start":"2026-04-15T03:11:12.18606Z","end":"2026-04-15T03:11:13.599109Z","steps":["trace[1105050004] 'read index received' (duration: 37.011µs)","trace[1105050004] 'applied index is now lower than readState.Index' (duration: 1.413010959s)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:11:13.599164Z","caller":"traceutil/trace.go:171","msg":"trace[1230519191] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"1.766470057s","start":"2026-04-15T03:11:11.832668Z","end":"2026-04-15T03:11:13.599138Z","steps":["trace[1230519191] 'process raft request' (duration: 227.499668ms)","trace[1230519191] 'compare' (duration: 1.538451142s)"],"step_count":2} {"level":"warn","ts":"2026-04-15T03:11:13.599278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:11.832647Z","time spent":"1.766558199s","remote":"127.0.0.1:56714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-15T03:11:13.599349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.413278387s","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-04-15T03:11:13.599381Z","caller":"traceutil/trace.go:171","msg":"trace[1800320142] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:618; }","duration":"1.413316618s","start":"2026-04-15T03:11:12.186054Z","end":"2026-04-15T03:11:13.599371Z","steps":["trace[1800320142] 'agreement among raft nodes before linearized reading' (duration: 1.413140003s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:13.599415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:12.185997Z","time spent":"1.413409622s","remote":"127.0.0.1:56464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-15T03:11:13.599478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395779838s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-04-15T03:11:13.599497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.406963063s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-15T03:11:13.599532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.082833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T03:11:13.599539Z","caller":"traceutil/trace.go:171","msg":"trace[302081457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"1.395867851s","start":"2026-04-15T03:11:12.203652Z","end":"2026-04-15T03:11:13.59952Z","steps":["trace[302081457] 'agreement among raft nodes before linearized reading' (duration: 1.395740726s)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:13.599578Z","caller":"traceutil/trace.go:171","msg":"trace[117481688] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"1.407102187s","start":"2026-04-15T03:11:12.192446Z","end":"2026-04-15T03:11:13.599548Z","steps":["trace[117481688] 'agreement among raft nodes before linearized reading' (duration: 1.40691774s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:13.599586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:12.203643Z","time spent":"1.395930883s","remote":"127.0.0.1:56464","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":"info","ts":"2026-04-15T03:11:13.599568Z","caller":"traceutil/trace.go:171","msg":"trace[1393095409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"700.117714ms","start":"2026-04-15T03:11:12.899438Z","end":"2026-04-15T03:11:13.599556Z","steps":["trace[1393095409] 'agreement among raft nodes before linearized reading' (duration: 700.064543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:13.599612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:12.192426Z","time spent":"1.407179529s","remote":"127.0.0.1:56464","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-15T03:11:13.599627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:12.899368Z","time spent":"700.252338ms","remote":"127.0.0.1:59964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-15T03:11:13.599721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.399066656s","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-04-15T03:11:13.599762Z","caller":"traceutil/trace.go:171","msg":"trace[129309547] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"1.399121738s","start":"2026-04-15T03:11:12.200627Z","end":"2026-04-15T03:11:13.599749Z","steps":["trace[129309547] 'agreement among raft nodes before linearized reading' (duration: 1.399052525s)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:13.599798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:12.200619Z","time spent":"1.3991695s","remote":"127.0.0.1:56464","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-04-15T03:11:15.130039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.230488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T03:11:15.130142Z","caller":"traceutil/trace.go:171","msg":"trace[1423536838] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:641; }","duration":"231.365333ms","start":"2026-04-15T03:11:14.898751Z","end":"2026-04-15T03:11:15.130116Z","steps":["trace[1423536838] 'range keys from in-memory index tree' (duration: 231.178686ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:18.565592Z","caller":"traceutil/trace.go:171","msg":"trace[2076534579] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"140.690351ms","start":"2026-04-15T03:11:18.424882Z","end":"2026-04-15T03:11:18.565573Z","steps":["trace[2076534579] 'process raft request' (duration: 140.548857ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:23.882285Z","caller":"traceutil/trace.go:171","msg":"trace[1069846449] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"109.489528ms","start":"2026-04-15T03:11:23.772777Z","end":"2026-04-15T03:11:23.882266Z","steps":["trace[1069846449] 'process raft request' (duration: 109.439047ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:23.88293Z","caller":"traceutil/trace.go:171","msg":"trace[1556072880] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"120.04476ms","start":"2026-04-15T03:11:23.762869Z","end":"2026-04-15T03:11:23.882913Z","steps":["trace[1556072880] 'process raft request' (duration: 118.848227ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:23.883226Z","caller":"traceutil/trace.go:171","msg":"trace[794670535] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"120.217295ms","start":"2026-04-15T03:11:23.762998Z","end":"2026-04-15T03:11:23.883215Z","steps":["trace[794670535] 'process raft request' (duration: 119.176228ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:29.502982Z","caller":"traceutil/trace.go:171","msg":"trace[800517759] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"721.312915ms","start":"2026-04-15T03:11:28.781645Z","end":"2026-04-15T03:11:29.502958Z","steps":["trace[800517759] 'process raft request' (duration: 721.156349ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:29.503141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:28.781625Z","time spent":"721.4344ms","remote":"127.0.0.1:56464","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-04-15T03:11:29.639928Z","caller":"traceutil/trace.go:171","msg":"trace[1510768049] linearizableReadLoop","detail":"{readStateIndex:806; appliedIndex:804; }","duration":"564.756308ms","start":"2026-04-15T03:11:29.075148Z","end":"2026-04-15T03:11:29.639904Z","steps":["trace[1510768049] 'read index received' (duration: 427.746276ms)","trace[1510768049] 'applied index is now lower than readState.Index' (duration: 137.009001ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:11:29.640055Z","caller":"traceutil/trace.go:171","msg":"trace[1347716376] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"855.442863ms","start":"2026-04-15T03:11:28.784603Z","end":"2026-04-15T03:11:29.640046Z","steps":["trace[1347716376] 'process raft request' (duration: 855.171293ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:29.640204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:28.784589Z","time spent":"855.493995ms","remote":"127.0.0.1:56378","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-15T03:11:29.640337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.180392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-15T03:11:29.640416Z","caller":"traceutil/trace.go:171","msg":"trace[1223071364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:777; }","duration":"565.300517ms","start":"2026-04-15T03:11:29.075093Z","end":"2026-04-15T03:11:29.640394Z","steps":["trace[1223071364] 'agreement among raft nodes before linearized reading' (duration: 565.181063ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:29.640407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.232512ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.53\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-15T03:11:29.640448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.314602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"warn","ts":"2026-04-15T03:11:29.640464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:29.075069Z","time spent":"565.38545ms","remote":"127.0.0.1:59964","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-04-15T03:11:29.64051Z","caller":"traceutil/trace.go:171","msg":"trace[1968954689] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:777; }","duration":"363.409716ms","start":"2026-04-15T03:11:29.277087Z","end":"2026-04-15T03:11:29.640496Z","steps":["trace[1968954689] 'agreement among raft nodes before linearized reading' (duration: 363.210139ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:11:29.640533Z","caller":"traceutil/trace.go:171","msg":"trace[1213423783] range","detail":"{range_begin:/registry/masterleases/199.204.45.53; range_end:; response_count:1; response_revision:777; }","duration":"540.361456ms","start":"2026-04-15T03:11:29.100126Z","end":"2026-04-15T03:11:29.640487Z","steps":["trace[1213423783] 'agreement among raft nodes before linearized reading' (duration: 540.098737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:11:29.640546Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:29.277066Z","time spent":"363.472688ms","remote":"127.0.0.1:56464","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-04-15T03:11:29.640623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-15T03:11:29.10011Z","time spent":"540.463249ms","remote":"127.0.0.1:56234","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.53\" "} {"level":"info","ts":"2026-04-15T03:11:53.921639Z","caller":"traceutil/trace.go:171","msg":"trace[1926607976] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"122.649285ms","start":"2026-04-15T03:11:53.798962Z","end":"2026-04-15T03:11:53.921611Z","steps":["trace[1926607976] 'process raft request' (duration: 122.475658ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:12:10.185443Z","caller":"traceutil/trace.go:171","msg":"trace[1282172741] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"143.899905ms","start":"2026-04-15T03:12:10.041518Z","end":"2026-04-15T03:12:10.185418Z","steps":["trace[1282172741] 'process raft request' (duration: 118.041793ms)","trace[1282172741] 'compare' (duration: 25.765338ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:12:10.187057Z","caller":"traceutil/trace.go:171","msg":"trace[1946243915] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"142.936095ms","start":"2026-04-15T03:12:10.044102Z","end":"2026-04-15T03:12:10.187038Z","steps":["trace[1946243915] 'process raft request' (duration: 141.809026ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:12:10.187224Z","caller":"traceutil/trace.go:171","msg":"trace[2115432174] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1115; }","duration":"128.736629ms","start":"2026-04-15T03:12:10.058451Z","end":"2026-04-15T03:12:10.187187Z","steps":["trace[2115432174] 'read index received' (duration: 101.09798ms)","trace[2115432174] 'applied index is now lower than readState.Index' (duration: 27.637619ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:12:10.187288Z","caller":"traceutil/trace.go:171","msg":"trace[1183054590] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"138.422082ms","start":"2026-04-15T03:12:10.048851Z","end":"2026-04-15T03:12:10.187273Z","steps":["trace[1183054590] 'process raft request' (duration: 138.104818ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:12:10.187423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.962678ms","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-04-15T03:12:10.187455Z","caller":"traceutil/trace.go:171","msg":"trace[680745676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1077; }","duration":"129.029571ms","start":"2026-04-15T03:12:10.058417Z","end":"2026-04-15T03:12:10.187447Z","steps":["trace[680745676] 'agreement among raft nodes before linearized reading' (duration: 128.892195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:12:10.187487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.760053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-15T03:12:10.187619Z","caller":"traceutil/trace.go:171","msg":"trace[1310810879] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1077; }","duration":"125.918068ms","start":"2026-04-15T03:12:10.061681Z","end":"2026-04-15T03:12:10.187599Z","steps":["trace[1310810879] 'agreement among raft nodes before linearized reading' (duration: 125.678718ms)"],"step_count":1} {"level":"info","ts":"2026-04-15T03:12:10.349693Z","caller":"traceutil/trace.go:171","msg":"trace[1189427195] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1118; }","duration":"126.792396ms","start":"2026-04-15T03:12:10.222881Z","end":"2026-04-15T03:12:10.349673Z","steps":["trace[1189427195] 'read index received' (duration: 59.09706ms)","trace[1189427195] 'applied index is now lower than readState.Index' (duration: 67.694106ms)"],"step_count":2} {"level":"info","ts":"2026-04-15T03:12:10.349773Z","caller":"traceutil/trace.go:171","msg":"trace[741071653] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"157.61658ms","start":"2026-04-15T03:12:10.192131Z","end":"2026-04-15T03:12:10.349748Z","steps":["trace[741071653] 'process raft request' (duration: 126.102736ms)","trace[741071653] 'compare' (duration: 31.369938ms)"],"step_count":2} {"level":"warn","ts":"2026-04-15T03:12:10.349914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.009395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-04-15T03:12:10.350023Z","caller":"traceutil/trace.go:171","msg":"trace[713659739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1079; }","duration":"127.145851ms","start":"2026-04-15T03:12:10.222855Z","end":"2026-04-15T03:12:10.350001Z","steps":["trace[713659739] 'agreement among raft nodes before linearized reading' (duration: 126.89111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:12:10.350055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.027502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/default/default\" ","response":"range_response_count:1 size:171"} {"level":"info","ts":"2026-04-15T03:12:10.35017Z","caller":"traceutil/trace.go:171","msg":"trace[796011301] range","detail":"{range_begin:/registry/serviceaccounts/default/default; range_end:; response_count:1; response_revision:1079; }","duration":"118.250751ms","start":"2026-04-15T03:12:10.231908Z","end":"2026-04-15T03:12:10.350159Z","steps":["trace[796011301] 'agreement among raft nodes before linearized reading' (duration: 117.955338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-15T03:12:10.350191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.97707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-15T03:12:10.35057Z","caller":"traceutil/trace.go:171","msg":"trace[288214705] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1079; }","duration":"103.214999ms","start":"2026-04-15T03:12:10.247172Z","end":"2026-04-15T03:12:10.350387Z","steps":["trace[288214705] 'agreement among raft nodes before linearized reading' (duration: 102.962189ms)"],"step_count":1}