{"level":"warn","ts":"2026-02-24T12:55:54.146521Z","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-24T12:55:54.146623Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.18: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.19.213.18:2380","--initial-cluster=instance=https://199.19.213.18:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.18:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.18: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-24T12:55:54.146709Z","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-24T12:55:54.146721Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-02-24T12:55:54.146743Z","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-24T12:55:54.147426Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"]} {"level":"info","ts":"2026-02-24T12:55:54.1475Z","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.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.18: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-24T12:55:54.151779Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.057132ms"} {"level":"info","ts":"2026-02-24T12:55:54.161441Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6d0358acb671c233","cluster-id":"ba212af698de913f"} {"level":"info","ts":"2026-02-24T12:55:54.161529Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=()"} {"level":"info","ts":"2026-02-24T12:55:54.161551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 0"} {"level":"info","ts":"2026-02-24T12:55:54.161565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6d0358acb671c233 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-24T12:55:54.161576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became follower at term 1"} {"level":"info","ts":"2026-02-24T12:55:54.161611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"warn","ts":"2026-02-24T12:55:54.170052Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-24T12:55:54.171831Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-24T12:55:54.173005Z","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-24T12:55:54.176109Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6d0358acb671c233","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-24T12:55:54.176649Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6d0358acb671c233","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-24T12:55:54.17681Z","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-24T12:55:54.182072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 switched to configuration voters=(7855219673882804787)"} {"level":"info","ts":"2026-02-24T12:55:54.182375Z","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-24T12:55:54.182433Z","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-24T12:55:54.182399Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","added-peer-id":"6d0358acb671c233","added-peer-peer-urls":["https://199.19.213.18:2380"]} {"level":"info","ts":"2026-02-24T12:55:54.186306Z","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-24T12:55:54.186542Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-02-24T12:55:54.186602Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.18:2380"} {"level":"info","ts":"2026-02-24T12:55:54.18721Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6d0358acb671c233","initial-advertise-peer-urls":["https://199.19.213.18:2380"],"listen-peer-urls":["https://199.19.213.18:2380"],"advertise-client-urls":["https://199.19.213.18:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.18:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-24T12:55:54.187264Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-24T12:55:54.565391Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 is starting a new election at term 1"} {"level":"info","ts":"2026-02-24T12:55:54.565438Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-24T12:55:54.565458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgPreVoteResp from 6d0358acb671c233 at term 1"} {"level":"info","ts":"2026-02-24T12:55:54.565481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became candidate at term 2"} {"level":"info","ts":"2026-02-24T12:55:54.565487Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 received MsgVoteResp from 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-02-24T12:55:54.565495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6d0358acb671c233 became leader at term 2"} {"level":"info","ts":"2026-02-24T12:55:54.565506Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6d0358acb671c233 elected leader 6d0358acb671c233 at term 2"} {"level":"info","ts":"2026-02-24T12:55:54.56914Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6d0358acb671c233","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.18:2379]}","request-path":"/0/members/6d0358acb671c233/attributes","cluster-id":"ba212af698de913f","publish-timeout":"7s"} {"level":"info","ts":"2026-02-24T12:55:54.569191Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T12:55:54.569211Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:55:54.57092Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-24T12:55:54.57104Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ba212af698de913f","local-member-id":"6d0358acb671c233","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:55:54.57531Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:55:54.575341Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-24T12:55:54.57338Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-24T12:55:54.57536Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-24T12:55:54.579549Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-24T12:55:54.587086Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.18:2379"} {"level":"info","ts":"2026-02-24T12:55:57.706346Z","caller":"traceutil/trace.go:171","msg":"trace[1354456545] transaction","detail":"{read_only:false; response_revision:160; number_of_response:1; }","duration":"221.012326ms","start":"2026-02-24T12:55:57.485298Z","end":"2026-02-24T12:55:57.70631Z","steps":["trace[1354456545] 'process raft request' (duration: 181.824909ms)","trace[1354456545] 'compare' (duration: 39.027046ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T12:56:03.193511Z","caller":"traceutil/trace.go:171","msg":"trace[1239491913] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"339.19481ms","start":"2026-02-24T12:56:02.85428Z","end":"2026-02-24T12:56:03.193475Z","steps":["trace[1239491913] 'process raft request' (duration: 338.971819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:03.194172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:02.854257Z","time spent":"339.364801ms","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":184,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-24T12:56:03.974245Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700608258618561,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-24T12:56:04.935051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.112719ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-24T12:56:04.935413Z","caller":"traceutil/trace.go:171","msg":"trace[678762683] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"1.728723817s","start":"2026-02-24T12:56:03.20666Z","end":"2026-02-24T12:56:04.935384Z","steps":["trace[678762683] 'process raft request' (duration: 890.853853ms)","trace[678762683] 'compare' (duration: 836.917097ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T12:56:04.935493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:03.206645Z","time spent":"1.728818348s","remote":"127.0.0.1:45738","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":205,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-24T12:56:04.93608Z","caller":"traceutil/trace.go:171","msg":"trace[373587566] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:304; }","duration":"1.462447586s","start":"2026-02-24T12:56:03.473619Z","end":"2026-02-24T12:56:04.936067Z","steps":["trace[373587566] 'read index received' (duration: 623.739535ms)","trace[373587566] 'applied index is now lower than readState.Index' (duration: 838.706581ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T12:56:04.936302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.462677177s","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-24T12:56:04.936332Z","caller":"traceutil/trace.go:171","msg":"trace[1806940347] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:293; }","duration":"1.462755787s","start":"2026-02-24T12:56:03.473566Z","end":"2026-02-24T12:56:04.936322Z","steps":["trace[1806940347] 'agreement among raft nodes before linearized reading' (duration: 1.462585486s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:04.936365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:03.473534Z","time spent":"1.462823878s","remote":"127.0.0.1:45778","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-02-24T12:56:04.936379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.029541348s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-24T12:56:04.936502Z","caller":"traceutil/trace.go:171","msg":"trace[251445161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:293; }","duration":"1.029708679s","start":"2026-02-24T12:56:03.90676Z","end":"2026-02-24T12:56:04.936468Z","steps":["trace[251445161] 'agreement among raft nodes before linearized reading' (duration: 1.029463818s)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:04.936585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:03.906737Z","time spent":"1.029832261s","remote":"127.0.0.1:45778","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-02-24T12:56:04.936653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.440822ms","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-24T12:56:04.936695Z","caller":"traceutil/trace.go:171","msg":"trace[284648607] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:293; }","duration":"346.518763ms","start":"2026-02-24T12:56:04.590167Z","end":"2026-02-24T12:56:04.936685Z","steps":["trace[284648607] 'agreement among raft nodes before linearized reading' (duration: 346.450072ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:04.936721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:04.590138Z","time spent":"346.577703ms","remote":"127.0.0.1:45778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-24T12:56:04.936816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.581756ms","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-24T12:56:04.93684Z","caller":"traceutil/trace.go:171","msg":"trace[1185604205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:293; }","duration":"501.646267ms","start":"2026-02-24T12:56:04.435186Z","end":"2026-02-24T12:56:04.936832Z","steps":["trace[1185604205] 'agreement among raft nodes before linearized reading' (duration: 501.601216ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:04.936864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:04.435158Z","time spent":"501.701237ms","remote":"127.0.0.1:45778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-24T12:56:05.090458Z","caller":"traceutil/trace.go:171","msg":"trace[1844445226] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"148.612694ms","start":"2026-02-24T12:56:04.941811Z","end":"2026-02-24T12:56:05.090424Z","steps":["trace[1844445226] 'process raft request' (duration: 148.466853ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T12:56:05.090708Z","caller":"traceutil/trace.go:171","msg":"trace[1317941025] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"149.563342ms","start":"2026-02-24T12:56:04.941129Z","end":"2026-02-24T12:56:05.090692Z","steps":["trace[1317941025] 'process raft request' (duration: 148.982768ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T12:56:05.090887Z","caller":"traceutil/trace.go:171","msg":"trace[716058227] linearizableReadLoop","detail":"{readStateIndex:309; appliedIndex:306; }","duration":"146.762711ms","start":"2026-02-24T12:56:04.944088Z","end":"2026-02-24T12:56:05.09085Z","steps":["trace[716058227] 'read index received' (duration: 57.140695ms)","trace[716058227] 'applied index is now lower than readState.Index' (duration: 89.620466ms)"],"step_count":2} {"level":"info","ts":"2026-02-24T12:56:05.09104Z","caller":"traceutil/trace.go:171","msg":"trace[348427431] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"148.321172ms","start":"2026-02-24T12:56:04.942671Z","end":"2026-02-24T12:56:05.090993Z","steps":["trace[348427431] 'process raft request' (duration: 147.701328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:05.091096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.981372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-24T12:56:05.091153Z","caller":"traceutil/trace.go:171","msg":"trace[1117247335] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:297; }","duration":"147.080783ms","start":"2026-02-24T12:56:04.944058Z","end":"2026-02-24T12:56:05.091138Z","steps":["trace[1117247335] 'agreement among raft nodes before linearized reading' (duration: 146.926672ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:26.885282Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":13993700608258618907,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-24T12:56:26.976972Z","caller":"traceutil/trace.go:171","msg":"trace[896306295] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"623.021864ms","start":"2026-02-24T12:56:26.353928Z","end":"2026-02-24T12:56:26.97695Z","steps":["trace[896306295] 'process raft request' (duration: 622.868123ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:26.977302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:26.353914Z","time spent":"623.127275ms","remote":"127.0.0.1:45712","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T12:56:26.981574Z","caller":"traceutil/trace.go:171","msg":"trace[69872716] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:487; }","duration":"597.103165ms","start":"2026-02-24T12:56:26.384448Z","end":"2026-02-24T12:56:26.981551Z","steps":["trace[69872716] 'read index received' (duration: 592.364224ms)","trace[69872716] 'applied index is now lower than readState.Index' (duration: 4.738261ms)"],"step_count":2} {"level":"warn","ts":"2026-02-24T12:56:26.981669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.208955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-24T12:56:26.981697Z","caller":"traceutil/trace.go:171","msg":"trace[1032745374] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:471; }","duration":"597.285566ms","start":"2026-02-24T12:56:26.384399Z","end":"2026-02-24T12:56:26.981684Z","steps":["trace[1032745374] 'agreement among raft nodes before linearized reading' (duration: 597.228405ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:26.981721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:26.384366Z","time spent":"597.350017ms","remote":"127.0.0.1:45542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-24T12:56:26.981692Z","caller":"traceutil/trace.go:171","msg":"trace[373055598] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"117.845154ms","start":"2026-02-24T12:56:26.863813Z","end":"2026-02-24T12:56:26.981658Z","steps":["trace[373055598] 'process raft request' (duration: 117.638073ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T12:56:33.387218Z","caller":"traceutil/trace.go:171","msg":"trace[393396546] linearizableReadLoop","detail":"{readStateIndex:530; appliedIndex:529; }","duration":"241.081413ms","start":"2026-02-24T12:56:33.146119Z","end":"2026-02-24T12:56:33.3872Z","steps":["trace[393396546] 'read index received' (duration: 240.982682ms)","trace[393396546] 'applied index is now lower than readState.Index' (duration: 97.951µs)"],"step_count":2} {"level":"warn","ts":"2026-02-24T12:56:33.38739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.262794ms","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-24T12:56:33.387358Z","caller":"traceutil/trace.go:171","msg":"trace[173122683] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"360.085818ms","start":"2026-02-24T12:56:33.027225Z","end":"2026-02-24T12:56:33.387311Z","steps":["trace[173122683] 'process raft request' (duration: 359.871107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:33.387581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:33.0272Z","time spent":"360.269669ms","remote":"127.0.0.1:45724","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T12:56:33.387422Z","caller":"traceutil/trace.go:171","msg":"trace[1093104324] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:511; }","duration":"241.337204ms","start":"2026-02-24T12:56:33.146076Z","end":"2026-02-24T12:56:33.387414Z","steps":["trace[1093104324] 'agreement among raft nodes before linearized reading' (duration: 241.204013ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:33.474878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.028751ms","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-24T12:56:33.474967Z","caller":"traceutil/trace.go:171","msg":"trace[952400494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:511; }","duration":"236.162401ms","start":"2026-02-24T12:56:33.238789Z","end":"2026-02-24T12:56:33.474951Z","steps":["trace[952400494] 'agreement among raft nodes before linearized reading' (duration: 235.94018ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:33.475213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.285628ms","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-24T12:56:33.475239Z","caller":"traceutil/trace.go:171","msg":"trace[533444353] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:511; }","duration":"226.328668ms","start":"2026-02-24T12:56:33.248904Z","end":"2026-02-24T12:56:33.475232Z","steps":["trace[533444353] 'agreement among raft nodes before linearized reading' (duration: 226.269767ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:33.475349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.915884ms","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-24T12:56:33.47537Z","caller":"traceutil/trace.go:171","msg":"trace[257126739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:511; }","duration":"231.974065ms","start":"2026-02-24T12:56:33.243391Z","end":"2026-02-24T12:56:33.475365Z","steps":["trace[257126739] 'agreement among raft nodes before linearized reading' (duration: 231.920754ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T12:56:33.800897Z","caller":"traceutil/trace.go:171","msg":"trace[639374941] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"409.171936ms","start":"2026-02-24T12:56:33.391699Z","end":"2026-02-24T12:56:33.800871Z","steps":["trace[639374941] 'process raft request' (duration: 409.029734ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:33.801039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:33.391678Z","time spent":"409.288197ms","remote":"127.0.0.1:45778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T12:56:33.824619Z","caller":"traceutil/trace.go:171","msg":"trace[1401029693] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"345.960228ms","start":"2026-02-24T12:56:33.478633Z","end":"2026-02-24T12:56:33.824594Z","steps":["trace[1401029693] 'process raft request' (duration: 345.795707ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:33.824775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:33.478614Z","time spent":"346.081399ms","remote":"127.0.0.1:45778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T12:56:33.825012Z","caller":"traceutil/trace.go:171","msg":"trace[1318527161] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"346.151789ms","start":"2026-02-24T12:56:33.478836Z","end":"2026-02-24T12:56:33.824987Z","steps":["trace[1318527161] 'process raft request' (duration: 346.030298ms)"],"step_count":1} {"level":"info","ts":"2026-02-24T12:56:33.825024Z","caller":"traceutil/trace.go:171","msg":"trace[381666227] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"346.224549ms","start":"2026-02-24T12:56:33.478778Z","end":"2026-02-24T12:56:33.825003Z","steps":["trace[381666227] 'process raft request' (duration: 345.776766ms)"],"step_count":1} {"level":"warn","ts":"2026-02-24T12:56:33.825155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:33.478771Z","time spent":"346.329401ms","remote":"127.0.0.1:45778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-24T12:56:33.82516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-24T12:56:33.478833Z","time spent":"346.24469ms","remote":"127.0.0.1:45778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-24T12:57:55.531394Z","caller":"traceutil/trace.go:171","msg":"trace[816453028] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"108.008862ms","start":"2026-02-24T12:57:55.423342Z","end":"2026-02-24T12:57:55.531351Z","steps":["trace[816453028] 'process raft request' (duration: 97.586839ms)"],"step_count":1}