{"level":"warn","ts":"2026-02-10T18:46:39.614681Z","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-10T18:46:39.614744Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.122: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.122:2380","--initial-cluster=instance=https://199.204.45.122:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.122:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.122: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-10T18:46:39.6148Z","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-10T18:46:39.614811Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.122:2380"]} {"level":"info","ts":"2026-02-10T18:46:39.614829Z","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-10T18:46:39.616874Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"]} {"level":"info","ts":"2026-02-10T18:46:39.616966Z","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.204.45.122:2380"],"listen-peer-urls":["https://199.204.45.122:2380"],"advertise-client-urls":["https://199.204.45.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.122: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-10T18:46:39.626334Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.643935ms"} {"level":"info","ts":"2026-02-10T18:46:39.636866Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d2c3f297b56db0c4","cluster-id":"becafec23d27c587"} {"level":"info","ts":"2026-02-10T18:46:39.636941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=()"} {"level":"info","ts":"2026-02-10T18:46:39.636971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 0"} {"level":"info","ts":"2026-02-10T18:46:39.636981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d2c3f297b56db0c4 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-10T18:46:39.636988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became follower at term 1"} {"level":"info","ts":"2026-02-10T18:46:39.637016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"} {"level":"warn","ts":"2026-02-10T18:46:39.653336Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-10T18:46:39.6627Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-10T18:46:39.672017Z","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-10T18:46:39.677936Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d2c3f297b56db0c4","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-10T18:46:39.680177Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d2c3f297b56db0c4","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-10T18:46:39.680341Z","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-10T18:46:39.680363Z","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-10T18:46:39.68037Z","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-10T18:46:39.680539Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 switched to configuration voters=(15187249101821292740)"} {"level":"info","ts":"2026-02-10T18:46:39.680593Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"becafec23d27c587","local-member-id":"d2c3f297b56db0c4","added-peer-id":"d2c3f297b56db0c4","added-peer-peer-urls":["https://199.204.45.122:2380"]} {"level":"info","ts":"2026-02-10T18:46:39.6953Z","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-10T18:46:39.695467Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d2c3f297b56db0c4","initial-advertise-peer-urls":["https://199.204.45.122:2380"],"listen-peer-urls":["https://199.204.45.122:2380"],"advertise-client-urls":["https://199.204.45.122:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.122:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-10T18:46:39.695489Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-10T18:46:39.696499Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.122:2380"} {"level":"info","ts":"2026-02-10T18:46:39.696533Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.122:2380"} {"level":"info","ts":"2026-02-10T18:46:40.138495Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 is starting a new election at term 1"} {"level":"info","ts":"2026-02-10T18:46:40.138535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-10T18:46:40.138549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgPreVoteResp from d2c3f297b56db0c4 at term 1"} {"level":"info","ts":"2026-02-10T18:46:40.138561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became candidate at term 2"} {"level":"info","ts":"2026-02-10T18:46:40.138572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 received MsgVoteResp from d2c3f297b56db0c4 at term 2"} {"level":"info","ts":"2026-02-10T18:46:40.13858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d2c3f297b56db0c4 became leader at term 2"} {"level":"info","ts":"2026-02-10T18:46:40.138587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d2c3f297b56db0c4 elected leader d2c3f297b56db0c4 at term 2"} {"level":"info","ts":"2026-02-10T18:46:40.141699Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:46:40.142478Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d2c3f297b56db0c4","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.122:2379]}","request-path":"/0/members/d2c3f297b56db0c4/attributes","cluster-id":"becafec23d27c587","publish-timeout":"7s"} {"level":"info","ts":"2026-02-10T18:46:40.142536Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T18:46:40.142604Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-10T18:46:40.144123Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-10T18:46:40.144169Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-10T18:46:40.145792Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.122:2379"} {"level":"info","ts":"2026-02-10T18:46:40.1461Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"becafec23d27c587","local-member-id":"d2c3f297b56db0c4","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:46:40.14625Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:46:40.146352Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-10T18:46:40.150983Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-10T18:46:55.737073Z","caller":"traceutil/trace.go:171","msg":"trace[1428673099] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"106.615084ms","start":"2026-02-10T18:46:55.630443Z","end":"2026-02-10T18:46:55.737058Z","steps":["trace[1428673099] 'process raft request' (duration: 101.416824ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.992806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.345888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-10T18:46:56.992905Z","caller":"traceutil/trace.go:171","msg":"trace[657393178] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:370; }","duration":"328.478239ms","start":"2026-02-10T18:46:56.664407Z","end":"2026-02-10T18:46:56.992885Z","steps":["trace[657393178] 'range keys from in-memory index tree' (duration: 328.259888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.992944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:56.664393Z","time spent":"328.542729ms","remote":"127.0.0.1:57028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":4058,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-10T18:46:56.993321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.479719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:56.993363Z","caller":"traceutil/trace.go:171","msg":"trace[223287127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:370; }","duration":"328.530679ms","start":"2026-02-10T18:46:56.664823Z","end":"2026-02-10T18:46:56.993354Z","steps":["trace[223287127] 'range keys from in-memory index tree' (duration: 328.455809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.993406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:56.664819Z","time spent":"328.57488ms","remote":"127.0.0.1:56584","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-02-10T18:46:56.993299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"720.383567ms","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-10T18:46:56.993848Z","caller":"traceutil/trace.go:171","msg":"trace[188446425] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:370; }","duration":"720.973792ms","start":"2026-02-10T18:46:56.272849Z","end":"2026-02-10T18:46:56.993823Z","steps":["trace[188446425] 'range keys from in-memory index tree' (duration: 720.234485ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.994052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.616808ms","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-10T18:46:56.994095Z","caller":"traceutil/trace.go:171","msg":"trace[1846813407] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:370; }","duration":"103.691268ms","start":"2026-02-10T18:46:56.890394Z","end":"2026-02-10T18:46:56.994086Z","steps":["trace[1846813407] 'range keys from in-memory index tree' (duration: 103.557718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.994058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:56.272827Z","time spent":"721.214084ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-10T18:46:56.994552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"448.35008ms","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-10T18:46:56.994594Z","caller":"traceutil/trace.go:171","msg":"trace[1770356901] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:370; }","duration":"448.42908ms","start":"2026-02-10T18:46:56.546156Z","end":"2026-02-10T18:46:56.994586Z","steps":["trace[1770356901] 'range keys from in-memory index tree' (duration: 448.287228ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.994621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:56.546137Z","time spent":"448.4776ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-10T18:46:56.994704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.81556ms","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-10T18:46:56.994732Z","caller":"traceutil/trace.go:171","msg":"trace[1096320933] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:370; }","duration":"721.84267ms","start":"2026-02-10T18:46:56.272882Z","end":"2026-02-10T18:46:56.994725Z","steps":["trace[1096320933] 'range keys from in-memory index tree' (duration: 721.708039ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.994761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:46:56.272827Z","time spent":"721.928981ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-10T18:46:56.995083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.366748ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:46:56.995156Z","caller":"traceutil/trace.go:171","msg":"trace[120568658] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:370; }","duration":"487.442998ms","start":"2026-02-10T18:46:56.507704Z","end":"2026-02-10T18:46:56.995147Z","steps":["trace[120568658] 'range keys from in-memory index tree' (duration: 487.359338ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:46:56.993733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.28678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6898"} {"level":"info","ts":"2026-02-10T18:46:56.995877Z","caller":"traceutil/trace.go:171","msg":"trace[1060120304] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:370; }","duration":"220.44141ms","start":"2026-02-10T18:46:56.775415Z","end":"2026-02-10T18:46:56.995857Z","steps":["trace[1060120304] 'range keys from in-memory index tree' (duration: 218.220889ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:14.012631Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:13.607781Z","time spent":"404.847099ms","remote":"127.0.0.1:56604","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-10T18:47:16.807539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.444385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:16.807608Z","caller":"traceutil/trace.go:171","msg":"trace[875411476] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"144.560797ms","start":"2026-02-10T18:47:16.663035Z","end":"2026-02-10T18:47:16.807596Z","steps":["trace[875411476] 'range keys from in-memory index tree' (duration: 144.390415ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:17.946952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":12737477482929002871,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-10T18:47:18.402846Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.210301425s","expected-duration":"1s"} {"level":"info","ts":"2026-02-10T18:47:18.403126Z","caller":"traceutil/trace.go:171","msg":"trace[1991188774] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.210661308s","start":"2026-02-10T18:47:17.192447Z","end":"2026-02-10T18:47:18.403108Z","steps":["trace[1991188774] 'process raft request' (duration: 1.210530497s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:18.403588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:17.192434Z","time spent":"1.210774669s","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:47:18.431179Z","caller":"traceutil/trace.go:171","msg":"trace[875027753] linearizableReadLoop","detail":"{readStateIndex:533; appliedIndex:530; }","duration":"984.458397ms","start":"2026-02-10T18:47:17.446704Z","end":"2026-02-10T18:47:18.431163Z","steps":["trace[875027753] 'read index received' (duration: 956.315754ms)","trace[875027753] 'applied index is now lower than readState.Index' (duration: 28.142053ms)"],"step_count":2} {"level":"info","ts":"2026-02-10T18:47:18.431383Z","caller":"traceutil/trace.go:171","msg":"trace[698090037] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.238161924s","start":"2026-02-10T18:47:17.193211Z","end":"2026-02-10T18:47:18.431373Z","steps":["trace[698090037] 'process raft request' (duration: 1.22065571s)","trace[698090037] 'compare' (duration: 17.206472ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:18.431451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:17.193205Z","time spent":"1.238197895s","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:47:18.431559Z","caller":"traceutil/trace.go:171","msg":"trace[748845748] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.237637031s","start":"2026-02-10T18:47:17.193916Z","end":"2026-02-10T18:47:18.431553Z","steps":["trace[748845748] 'process raft request' (duration: 1.237218018s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:18.4316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:17.193911Z","time spent":"1.237660581s","remote":"127.0.0.1:56830","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-02-10T18:47:18.431806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"767.592554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:18.431832Z","caller":"traceutil/trace.go:171","msg":"trace[563170196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:513; }","duration":"767.640444ms","start":"2026-02-10T18:47:17.664181Z","end":"2026-02-10T18:47:18.431822Z","steps":["trace[563170196] 'agreement among raft nodes before linearized reading' (duration: 767.604804ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:18.431849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:17.664168Z","time spent":"767.678064ms","remote":"127.0.0.1:56584","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-02-10T18:47:18.432393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"985.684277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9gs2g\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-10T18:47:18.432415Z","caller":"traceutil/trace.go:171","msg":"trace[944288081] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9gs2g; range_end:; response_count:1; response_revision:513; }","duration":"985.735677ms","start":"2026-02-10T18:47:17.446673Z","end":"2026-02-10T18:47:18.432408Z","steps":["trace[944288081] 'agreement among raft nodes before linearized reading' (duration: 984.996501ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:18.432435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:17.446658Z","time spent":"985.773747ms","remote":"127.0.0.1:56742","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16680,"request content":"key:\"/registry/pods/kube-system/cilium-9gs2g\" "} {"level":"warn","ts":"2026-02-10T18:47:19.536101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.261465ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-10T18:47:19.537002Z","caller":"traceutil/trace.go:171","msg":"trace[513506324] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.078869848s","start":"2026-02-10T18:47:18.458096Z","end":"2026-02-10T18:47:19.536966Z","steps":["trace[513506324] 'process raft request' (duration: 458.524354ms)","trace[513506324] 'compare' (duration: 619.026463ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:19.537114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:18.458081Z","time spent":"1.078967489s","remote":"127.0.0.1:56742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16803,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:47:19.537222Z","caller":"traceutil/trace.go:171","msg":"trace[172651336] linearizableReadLoop","detail":"{readStateIndex:534; appliedIndex:533; }","duration":"872.43364ms","start":"2026-02-10T18:47:18.664781Z","end":"2026-02-10T18:47:19.537215Z","steps":["trace[172651336] 'read index received' (duration: 251.845454ms)","trace[172651336] 'applied index is now lower than readState.Index' (duration: 620.587366ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:20.218444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.251082ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-02-10T18:47:20.218539Z","caller":"traceutil/trace.go:171","msg":"trace[607720227] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"681.285755ms","start":"2026-02-10T18:47:19.537233Z","end":"2026-02-10T18:47:20.218519Z","steps":["trace[607720227] 'read index received' (duration: 74.701µs)","trace[607720227] 'applied index is now lower than readState.Index' (duration: 681.209774ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:20.218625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.553828386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:20.218672Z","caller":"traceutil/trace.go:171","msg":"trace[149795655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:514; }","duration":"1.553881026s","start":"2026-02-10T18:47:18.664777Z","end":"2026-02-10T18:47:20.218659Z","steps":["trace[149795655] 'agreement among raft nodes before linearized reading' (duration: 872.505691ms)","trace[149795655] 'range keys from in-memory index tree' (duration: 681.308835ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:20.218679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.016054573s","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-10T18:47:20.218694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:18.664735Z","time spent":"1.553954998s","remote":"127.0.0.1:56584","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-02-10T18:47:20.218708Z","caller":"traceutil/trace.go:171","msg":"trace[1365203497] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:514; }","duration":"1.016126924s","start":"2026-02-10T18:47:19.202572Z","end":"2026-02-10T18:47:20.218699Z","steps":["trace[1365203497] 'agreement among raft nodes before linearized reading' (duration: 1.015996573s)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:47:20.218743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:47:19.202558Z","time spent":"1.016176774s","remote":"127.0.0.1:56830","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-02-10T18:47:24.761478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.520246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"info","ts":"2026-02-10T18:47:24.761556Z","caller":"traceutil/trace.go:171","msg":"trace[1750531810] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:587; }","duration":"127.62427ms","start":"2026-02-10T18:47:24.633915Z","end":"2026-02-10T18:47:24.761539Z","steps":["trace[1750531810] 'range keys from in-memory index tree' (duration: 127.458173ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:47:40.85594Z","caller":"traceutil/trace.go:171","msg":"trace[852340946] linearizableReadLoop","detail":"{readStateIndex:744; appliedIndex:743; }","duration":"192.449301ms","start":"2026-02-10T18:47:40.663473Z","end":"2026-02-10T18:47:40.855922Z","steps":["trace[852340946] 'read index received' (duration: 192.326606ms)","trace[852340946] 'applied index is now lower than readState.Index' (duration: 122.165µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:47:40.856033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.552194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:47:40.856088Z","caller":"traceutil/trace.go:171","msg":"trace[1860378312] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:718; }","duration":"192.640327ms","start":"2026-02-10T18:47:40.66344Z","end":"2026-02-10T18:47:40.85608Z","steps":["trace[1860378312] 'agreement among raft nodes before linearized reading' (duration: 192.549934ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:47:40.856289Z","caller":"traceutil/trace.go:171","msg":"trace[388697112] transaction","detail":"{read_only:false; response_revision:718; number_of_response:1; }","duration":"231.320839ms","start":"2026-02-10T18:47:40.624962Z","end":"2026-02-10T18:47:40.856283Z","steps":["trace[388697112] 'process raft request' (duration: 230.878874ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:39.232892Z","caller":"traceutil/trace.go:171","msg":"trace[1637594151] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"331.862276ms","start":"2026-02-10T18:48:38.901022Z","end":"2026-02-10T18:48:39.232884Z","steps":["trace[1637594151] 'process raft request' (duration: 331.503419ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:39.23298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:38.901006Z","time spent":"331.921497ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:39.232847Z","caller":"traceutil/trace.go:171","msg":"trace[493342622] linearizableReadLoop","detail":"{readStateIndex:959; appliedIndex:958; }","duration":"236.383014ms","start":"2026-02-10T18:48:38.996447Z","end":"2026-02-10T18:48:39.23283Z","steps":["trace[493342622] 'read index received' (duration: 236.006036ms)","trace[493342622] 'applied index is now lower than readState.Index' (duration: 376.048µs)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:48:39.233292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.402916ms","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-10T18:48:39.233315Z","caller":"traceutil/trace.go:171","msg":"trace[408037601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:919; }","duration":"127.462657ms","start":"2026-02-10T18:48:39.105845Z","end":"2026-02-10T18:48:39.233307Z","steps":["trace[408037601] 'agreement among raft nodes before linearized reading' (duration: 127.382225ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:39.235015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.558109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:48:39.235048Z","caller":"traceutil/trace.go:171","msg":"trace[1050611746] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:919; }","duration":"238.619089ms","start":"2026-02-10T18:48:38.996418Z","end":"2026-02-10T18:48:39.235037Z","steps":["trace[1050611746] 'agreement among raft nodes before linearized reading' (duration: 236.777951ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:48.716416Z","caller":"traceutil/trace.go:171","msg":"trace[97541063] transaction","detail":"{read_only:false; response_revision:950; number_of_response:1; }","duration":"816.585977ms","start":"2026-02-10T18:48:47.89981Z","end":"2026-02-10T18:48:48.716396Z","steps":["trace[97541063] 'process raft request' (duration: 816.456864ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:48.716573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:47.899785Z","time spent":"816.71737ms","remote":"127.0.0.1:56830","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-10T18:48:48.789592Z","caller":"traceutil/trace.go:171","msg":"trace[1371816004] linearizableReadLoop","detail":"{readStateIndex:992; appliedIndex:991; }","duration":"124.385027ms","start":"2026-02-10T18:48:48.665186Z","end":"2026-02-10T18:48:48.789571Z","steps":["trace[1371816004] 'read index received' (duration: 51.835443ms)","trace[1371816004] 'applied index is now lower than readState.Index' (duration: 72.548634ms)"],"step_count":2} {"level":"warn","ts":"2026-02-10T18:48:48.790217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.017379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-10T18:48:48.790277Z","caller":"traceutil/trace.go:171","msg":"trace[485662647] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:951; }","duration":"125.115621ms","start":"2026-02-10T18:48:48.665147Z","end":"2026-02-10T18:48:48.790263Z","steps":["trace[485662647] 'agreement among raft nodes before linearized reading' (duration: 125.02017ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:48.790634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.896067ms","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-10T18:48:48.796302Z","caller":"traceutil/trace.go:171","msg":"trace[641272694] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:951; }","duration":"130.589257ms","start":"2026-02-10T18:48:48.665694Z","end":"2026-02-10T18:48:48.796284Z","steps":["trace[641272694] 'agreement among raft nodes before linearized reading' (duration: 124.760864ms)"],"step_count":1} {"level":"info","ts":"2026-02-10T18:48:48.79073Z","caller":"traceutil/trace.go:171","msg":"trace[1033348233] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"630.425251ms","start":"2026-02-10T18:48:48.160033Z","end":"2026-02-10T18:48:48.790459Z","steps":["trace[1033348233] 'process raft request' (duration: 627.533875ms)"],"step_count":1} {"level":"warn","ts":"2026-02-10T18:48:48.797053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-10T18:48:48.160018Z","time spent":"636.968768ms","remote":"127.0.0.1:56734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"}