{"level":"warn","ts":"2026-02-10T14:57:04.254937Z","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-10T14:57:04.25507Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.95: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.95:2380","--initial-cluster=instance=https://199.19.213.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.95: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-10T14:57:04.255164Z","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-10T14:57:04.255177Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.95:2380"]} {"level":"info","ts":"2026-02-10T14:57:04.255212Z","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-10T14:57:04.258306Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"]} {"level":"info","ts":"2026-02-10T14:57:04.258417Z","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":2,"max-cpu-available":2,"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.95:2380"],"listen-peer-urls":["https://199.19.213.95:2380"],"advertise-client-urls":["https://199.19.213.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.95: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-10T14:57:04.268645Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.859163ms"} {"level":"info","ts":"2026-02-10T14:57:04.318286Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"371c7c2e52231793","cluster-id":"c115742627eabb7c"} {"level":"info","ts":"2026-02-10T14:57:04.31854Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T14:57:04.318573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became follower at term 0"} {"level":"info","ts":"2026-02-10T14:57:04.318589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 371c7c2e52231793 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T14:57:04.318602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became follower at term 1"} {"level":"info","ts":"2026-02-10T14:57:04.325417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=(3971185509822306195)"} {"level":"warn","ts":"2026-02-10T14:57:04.334528Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T14:57:04.34869Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T14:57:04.353588Z","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-10T14:57:04.360124Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"371c7c2e52231793","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T14:57:04.365479Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"371c7c2e52231793","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T14:57:04.365723Z","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-10T14:57:04.365796Z","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-10T14:57:04.365833Z","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-10T14:57:04.374881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 switched to configuration voters=(3971185509822306195)"} {"level":"info","ts":"2026-02-10T14:57:04.387298Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c115742627eabb7c","local-member-id":"371c7c2e52231793","added-peer-id":"371c7c2e52231793","added-peer-peer-urls":["https://199.19.213.95:2380"]} {"level":"info","ts":"2026-02-10T14:57:04.391373Z","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-10T14:57:04.391674Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"371c7c2e52231793","initial-advertise-peer-urls":["https://199.19.213.95:2380"],"listen-peer-urls":["https://199.19.213.95:2380"],"advertise-client-urls":["https://199.19.213.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T14:57:04.391715Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T14:57:04.39224Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.95:2380"} {"level":"info","ts":"2026-02-10T14:57:04.393628Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.95:2380"} {"level":"info","ts":"2026-02-10T14:57:05.126073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T14:57:05.12621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T14:57:05.126244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 received MsgPreVoteResp from 371c7c2e52231793 at term 1"} {"level":"info","ts":"2026-02-10T14:57:05.12629Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became candidate at term 2"} {"level":"info","ts":"2026-02-10T14:57:05.126409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 received MsgVoteResp from 371c7c2e52231793 at term 2"} {"level":"info","ts":"2026-02-10T14:57:05.126502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"371c7c2e52231793 became leader at term 2"} {"level":"info","ts":"2026-02-10T14:57:05.126558Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 371c7c2e52231793 elected leader 371c7c2e52231793 at term 2"} {"level":"info","ts":"2026-02-10T14:57:05.128368Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:57:05.131642Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"371c7c2e52231793","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.95:2379]}","request-path":"/0/members/371c7c2e52231793/attributes","cluster-id":"c115742627eabb7c","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T14:57:05.13366Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:57:05.133896Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c115742627eabb7c","local-member-id":"371c7c2e52231793","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:57:05.133994Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:57:05.134033Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T14:57:05.134075Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T14:57:05.148639Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T14:57:05.156502Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T14:57:05.156567Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T14:57:05.210132Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.95:2379"} {"level":"info","ts":"2026-02-10T14:57:35.736218Z","caller":"traceutil/trace.go:171","msg":"trace[317611105] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"238.061473ms","start":"2026-02-10T14:57:35.498133Z","end":"2026-02-10T14:57:35.736194Z","steps":["trace[317611105] 'process raft request' (duration: 236.818286ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:37.233375Z","caller":"traceutil/trace.go:171","msg":"trace[1853182306] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"194.532351ms","start":"2026-02-10T14:57:37.038819Z","end":"2026-02-10T14:57:37.233351Z","steps":["trace[1853182306] 'process raft request' (duration: 194.405919ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:37.233914Z","caller":"traceutil/trace.go:171","msg":"trace[2075233205] linearizableReadLoop","detail":"{readStateIndex:493; appliedIndex:493; }","duration":"165.072435ms","start":"2026-02-10T14:57:37.068829Z","end":"2026-02-10T14:57:37.233902Z","steps":["trace[2075233205] 'read index received' (duration: 165.068155ms)","trace[2075233205] 'applied index is now lower than readState.Index' (duration: 3.5µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:37.234024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.181365ms","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-10T14:57:37.234081Z","caller":"traceutil/trace.go:171","msg":"trace[694358099] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:478; }","duration":"165.278625ms","start":"2026-02-10T14:57:37.068792Z","end":"2026-02-10T14:57:37.23407Z","steps":["trace[694358099] 'agreement among raft nodes before linearized reading' (duration: 165.177035ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:37.302376Z","caller":"traceutil/trace.go:171","msg":"trace[1734144187] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"155.567389ms","start":"2026-02-10T14:57:37.146792Z","end":"2026-02-10T14:57:37.302359Z","steps":["trace[1734144187] 'process raft request' (duration: 155.481051ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:37.302511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.021135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-10T14:57:37.302573Z","caller":"traceutil/trace.go:171","msg":"trace[502994285] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:479; }","duration":"157.131165ms","start":"2026-02-10T14:57:37.145429Z","end":"2026-02-10T14:57:37.30256Z","steps":["trace[502994285] 'agreement among raft nodes before linearized reading' (duration: 156.950918ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:37.302718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.593951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-10T14:57:37.302731Z","caller":"traceutil/trace.go:171","msg":"trace[596152672] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:479; }","duration":"136.634374ms","start":"2026-02-10T14:57:37.166093Z","end":"2026-02-10T14:57:37.302727Z","steps":["trace[596152672] 'agreement among raft nodes before linearized reading' (duration: 136.594231ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:38.87897Z","caller":"traceutil/trace.go:171","msg":"trace[138957766] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:498; }","duration":"244.986711ms","start":"2026-02-10T14:57:38.633969Z","end":"2026-02-10T14:57:38.878955Z","steps":["trace[138957766] 'read index received' (duration: 244.913965ms)","trace[138957766] 'applied index is now lower than readState.Index' (duration: 71.636µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:38.878983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:38.514169Z","time spent":"364.808057ms","remote":"127.0.0.1:45944","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-10T14:57:38.879047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.069279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:57:38.879065Z","caller":"traceutil/trace.go:171","msg":"trace[637774375] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"245.137336ms","start":"2026-02-10T14:57:38.633923Z","end":"2026-02-10T14:57:38.87906Z","steps":["trace[637774375] 'agreement among raft nodes before linearized reading' (duration: 245.090882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:39.380956Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1698873317740726579,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T14:57:39.989182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.388567ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:57:39.989361Z","caller":"traceutil/trace.go:171","msg":"trace[1706459424] linearizableReadLoop","detail":"{readStateIndex:500; appliedIndex:499; }","duration":"1.109217587s","start":"2026-02-10T14:57:38.88012Z","end":"2026-02-10T14:57:39.989337Z","steps":["trace[1706459424] 'read index received' (duration: 519.823667ms)","trace[1706459424] 'applied index is now lower than readState.Index' (duration: 589.39257ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:57:39.989398Z","caller":"traceutil/trace.go:171","msg":"trace[176918071] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"1.10956472s","start":"2026-02-10T14:57:38.879806Z","end":"2026-02-10T14:57:39.989371Z","steps":["trace[176918071] 'process raft request' (duration: 520.188341ms)","trace[176918071] 'compare' (duration: 588.254165ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:39.989491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:38.879794Z","time spent":"1.109645438s","remote":"127.0.0.1:45944","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:57:39.98955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109409915s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:57:39.989579Z","caller":"traceutil/trace.go:171","msg":"trace[1938384853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:484; }","duration":"1.109464651s","start":"2026-02-10T14:57:38.880105Z","end":"2026-02-10T14:57:39.989569Z","steps":["trace[1938384853] 'agreement among raft nodes before linearized reading' (duration: 1.109358241s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:39.989624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:38.880098Z","time spent":"1.109508104s","remote":"127.0.0.1:45920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-10T14:57:39.989788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"752.080782ms","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-02-10T14:57:39.989798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.406911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-10T14:57:39.989826Z","caller":"traceutil/trace.go:171","msg":"trace[798049583] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:484; }","duration":"603.457025ms","start":"2026-02-10T14:57:39.386361Z","end":"2026-02-10T14:57:39.989818Z","steps":["trace[798049583] 'agreement among raft nodes before linearized reading' (duration: 603.40316ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:39.989818Z","caller":"traceutil/trace.go:171","msg":"trace[1213303496] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:484; }","duration":"752.134817ms","start":"2026-02-10T14:57:39.237674Z","end":"2026-02-10T14:57:39.989809Z","steps":["trace[1213303496] 'agreement among raft nodes before linearized reading' (duration: 752.081782ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:39.989854Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:39.386349Z","time spent":"603.49772ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T14:57:39.98986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:39.237639Z","time spent":"752.213365ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T14:57:39.990038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.658825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-10T14:57:39.990066Z","caller":"traceutil/trace.go:171","msg":"trace[2077655131] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:484; }","duration":"603.716319ms","start":"2026-02-10T14:57:39.386341Z","end":"2026-02-10T14:57:39.990058Z","steps":["trace[2077655131] 'agreement among raft nodes before linearized reading' (duration: 603.665254ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:39.990091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:39.386325Z","time spent":"603.759804ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T14:57:39.99024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.009904ms","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-10T14:57:39.990268Z","caller":"traceutil/trace.go:171","msg":"trace[1169963128] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:484; }","duration":"666.065129ms","start":"2026-02-10T14:57:39.324195Z","end":"2026-02-10T14:57:39.99026Z","steps":["trace[1169963128] 'agreement among raft nodes before linearized reading' (duration: 666.015314ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:39.990293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:39.324152Z","time spent":"666.106022ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-10T14:57:46.458159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.729779ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T14:57:46.458283Z","caller":"traceutil/trace.go:171","msg":"trace[920716581] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:539; }","duration":"413.3776ms","start":"2026-02-10T14:57:46.044894Z","end":"2026-02-10T14:57:46.458271Z","steps":["trace[920716581] 'read index received' (duration: 159.485075ms)","trace[920716581] 'applied index is now lower than readState.Index' (duration: 253.891635ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:57:46.458428Z","caller":"traceutil/trace.go:171","msg":"trace[591877119] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"416.718111ms","start":"2026-02-10T14:57:46.041702Z","end":"2026-02-10T14:57:46.45842Z","steps":["trace[591877119] 'process raft request' (duration: 162.669858ms)","trace[591877119] 'compare' (duration: 253.655945ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:46.458503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:46.041694Z","time spent":"416.755388ms","remote":"127.0.0.1:46188","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-10T14:57:46.458617Z","caller":"traceutil/trace.go:171","msg":"trace[757891800] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"415.193204ms","start":"2026-02-10T14:57:46.043412Z","end":"2026-02-10T14:57:46.458606Z","steps":["trace[757891800] 'process raft request' (duration: 414.825594ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:46.458658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:46.043395Z","time spent":"415.23719ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:57:46.458782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.884268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-02-10T14:57:46.458801Z","caller":"traceutil/trace.go:171","msg":"trace[1936878309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:524; }","duration":"413.913556ms","start":"2026-02-10T14:57:46.044881Z","end":"2026-02-10T14:57:46.458794Z","steps":["trace[1936878309] 'agreement among raft nodes before linearized reading' (duration: 413.839862ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:46.458819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:46.044876Z","time spent":"413.939364ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T14:57:46.458919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.757049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-10T14:57:46.458935Z","caller":"traceutil/trace.go:171","msg":"trace[1119054335] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:524; }","duration":"413.780646ms","start":"2026-02-10T14:57:46.045149Z","end":"2026-02-10T14:57:46.45893Z","steps":["trace[1119054335] 'agreement among raft nodes before linearized reading' (duration: 413.73318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:46.458951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:46.045146Z","time spent":"413.801585ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T14:57:46.459106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.263343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbs66\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-10T14:57:46.459124Z","caller":"traceutil/trace.go:171","msg":"trace[2134005678] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbs66; range_end:; response_count:1; response_revision:524; }","duration":"121.307868ms","start":"2026-02-10T14:57:46.337811Z","end":"2026-02-10T14:57:46.459119Z","steps":["trace[2134005678] 'agreement among raft nodes before linearized reading' (duration: 121.260402ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:46.697897Z","caller":"traceutil/trace.go:171","msg":"trace[1512363008] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"229.781065ms","start":"2026-02-10T14:57:46.468098Z","end":"2026-02-10T14:57:46.697879Z","steps":["trace[1512363008] 'process raft request' (duration: 229.481669ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:46.69806Z","caller":"traceutil/trace.go:171","msg":"trace[1492696278] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"227.74645ms","start":"2026-02-10T14:57:46.470305Z","end":"2026-02-10T14:57:46.698052Z","steps":["trace[1492696278] 'process raft request' (duration: 227.362731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:48.135385Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":1698873317740726669,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-10T14:57:48.548009Z","caller":"traceutil/trace.go:171","msg":"trace[1416297911] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:544; }","duration":"913.532036ms","start":"2026-02-10T14:57:47.634457Z","end":"2026-02-10T14:57:48.547989Z","steps":["trace[1416297911] 'read index received' (duration: 913.359589ms)","trace[1416297911] 'applied index is now lower than readState.Index' (duration: 171.077µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:57:48.548383Z","caller":"traceutil/trace.go:171","msg":"trace[894875091] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"989.943113ms","start":"2026-02-10T14:57:47.558425Z","end":"2026-02-10T14:57:48.548368Z","steps":["trace[894875091] 'process raft request' (duration: 989.450261ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:48.548487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:47.558407Z","time spent":"990.012508ms","remote":"127.0.0.1:46188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-10T14:57:48.548935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"914.219394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T14:57:48.548983Z","caller":"traceutil/trace.go:171","msg":"trace[199788803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:528; }","duration":"914.5494ms","start":"2026-02-10T14:57:47.634426Z","end":"2026-02-10T14:57:48.548976Z","steps":["trace[199788803] 'agreement among raft nodes before linearized reading' (duration: 914.221534ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:48.549005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T14:57:47.634412Z","time spent":"914.586457ms","remote":"127.0.0.1:45934","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-10T14:57:48.692252Z","caller":"traceutil/trace.go:171","msg":"trace[1067059387] linearizableReadLoop","detail":"{readStateIndex:548; appliedIndex:545; }","duration":"135.079632ms","start":"2026-02-10T14:57:48.557157Z","end":"2026-02-10T14:57:48.692237Z","steps":["trace[1067059387] 'read index received' (duration: 131.596935ms)","trace[1067059387] 'applied index is now lower than readState.Index' (duration: 3.481937ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:57:48.692589Z","caller":"traceutil/trace.go:171","msg":"trace[488330024] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"139.70576ms","start":"2026-02-10T14:57:48.552875Z","end":"2026-02-10T14:57:48.692581Z","steps":["trace[488330024] 'process raft request' (duration: 139.270753ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:48.692671Z","caller":"traceutil/trace.go:171","msg":"trace[452517367] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"138.499752ms","start":"2026-02-10T14:57:48.554166Z","end":"2026-02-10T14:57:48.692665Z","steps":["trace[452517367] 'process raft request' (duration: 138.048247ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:57:48.692799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.62597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-10T14:57:48.69282Z","caller":"traceutil/trace.go:171","msg":"trace[68391435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:530; }","duration":"135.672096ms","start":"2026-02-10T14:57:48.557142Z","end":"2026-02-10T14:57:48.692814Z","steps":["trace[68391435] 'agreement among raft nodes before linearized reading' (duration: 135.588132ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:50.505721Z","caller":"traceutil/trace.go:171","msg":"trace[161573618] linearizableReadLoop","detail":"{readStateIndex:556; appliedIndex:555; }","duration":"138.460995ms","start":"2026-02-10T14:57:50.36724Z","end":"2026-02-10T14:57:50.505701Z","steps":["trace[161573618] 'read index received' (duration: 138.330584ms)","trace[161573618] 'applied index is now lower than readState.Index' (duration: 129.721µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:50.505858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.597904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-kbs66\" ","response":"range_response_count:1 size:16912"} {"level":"info","ts":"2026-02-10T14:57:50.50588Z","caller":"traceutil/trace.go:171","msg":"trace[1323547444] range","detail":"{range_begin:/registry/pods/kube-system/cilium-kbs66; range_end:; response_count:1; response_revision:538; }","duration":"138.635781ms","start":"2026-02-10T14:57:50.367237Z","end":"2026-02-10T14:57:50.505873Z","steps":["trace[1323547444] 'agreement among raft nodes before linearized reading' (duration: 138.530519ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:50.50603Z","caller":"traceutil/trace.go:171","msg":"trace[1345724380] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"139.012135ms","start":"2026-02-10T14:57:50.367012Z","end":"2026-02-10T14:57:50.506024Z","steps":["trace[1345724380] 'process raft request' (duration: 138.605014ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:57:50.895898Z","caller":"traceutil/trace.go:171","msg":"trace[1585784838] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"177.498909ms","start":"2026-02-10T14:57:50.718379Z","end":"2026-02-10T14:57:50.895878Z","steps":["trace[1585784838] 'process raft request' (duration: 123.080098ms)","trace[1585784838] 'compare' (duration: 53.715131ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:57:50.895546Z","caller":"traceutil/trace.go:171","msg":"trace[566753582] linearizableReadLoop","detail":"{readStateIndex:564; appliedIndex:563; }","duration":"168.003704ms","start":"2026-02-10T14:57:50.727518Z","end":"2026-02-10T14:57:50.895522Z","steps":["trace[566753582] 'read index received' (duration: 113.896061ms)","trace[566753582] 'applied index is now lower than readState.Index' (duration: 54.106573ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T14:57:50.89866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.119532ms","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-10T14:57:50.898691Z","caller":"traceutil/trace.go:171","msg":"trace[1964381029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:546; }","duration":"171.182338ms","start":"2026-02-10T14:57:50.727501Z","end":"2026-02-10T14:57:50.898683Z","steps":["trace[1964381029] 'agreement among raft nodes before linearized reading' (duration: 168.728763ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:59:09.502323Z","caller":"traceutil/trace.go:171","msg":"trace[1209706812] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"163.761068ms","start":"2026-02-10T14:59:09.338544Z","end":"2026-02-10T14:59:09.502306Z","steps":["trace[1209706812] 'process raft request' (duration: 163.646284ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:59:09.503151Z","caller":"traceutil/trace.go:171","msg":"trace[2103808254] linearizableReadLoop","detail":"{readStateIndex:978; appliedIndex:977; }","duration":"114.709743ms","start":"2026-02-10T14:59:09.388432Z","end":"2026-02-10T14:59:09.503142Z","steps":["trace[2103808254] 'read index received' (duration: 114.318888ms)","trace[2103808254] 'applied index is now lower than readState.Index' (duration: 390.125µs)"],"step_count":2} {"level":"info","ts":"2026-02-10T14:59:09.503397Z","caller":"traceutil/trace.go:171","msg":"trace[1590588414] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"163.472668ms","start":"2026-02-10T14:59:09.339916Z","end":"2026-02-10T14:59:09.503389Z","steps":["trace[1590588414] 'process raft request' (duration: 163.168027ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:59:09.50366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.22031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-10T14:59:09.503688Z","caller":"traceutil/trace.go:171","msg":"trace[723941239] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:941; }","duration":"115.294202ms","start":"2026-02-10T14:59:09.388387Z","end":"2026-02-10T14:59:09.503681Z","steps":["trace[723941239] 'agreement among raft nodes before linearized reading' (duration: 115.183318ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T14:59:09.503931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.506571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-10T14:59:09.503957Z","caller":"traceutil/trace.go:171","msg":"trace[570157605] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:941; }","duration":"105.574003ms","start":"2026-02-10T14:59:09.398377Z","end":"2026-02-10T14:59:09.503951Z","steps":["trace[570157605] 'agreement among raft nodes before linearized reading' (duration: 105.49595ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T14:59:12.827441Z","caller":"traceutil/trace.go:171","msg":"trace[737147675] transaction","detail":"{read_only:false; response_revision:953; number_of_response:1; }","duration":"109.872751ms","start":"2026-02-10T14:59:12.717543Z","end":"2026-02-10T14:59:12.827415Z","steps":["trace[737147675] 'process raft request' (duration: 101.151539ms)"],"step_count":1}