{"level":"warn","ts":"2026-03-09T01:39:35.821449Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-09T01:39:35.821571Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113: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.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-03-09T01:39:35.821911Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-03-09T01:39:35.821937Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]}
{"level":"info","ts":"2026-03-09T01:39:35.822074Z","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-03-09T01:39:35.82305Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]}
{"level":"info","ts":"2026-03-09T01:39:35.823238Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-03-09T01:39:35.827262Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.66805ms"}
{"level":"info","ts":"2026-03-09T01:39:35.834451Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"}
{"level":"info","ts":"2026-03-09T01:39:35.835258Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"}
{"level":"info","ts":"2026-03-09T01:39:35.835308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"}
{"level":"info","ts":"2026-03-09T01:39:35.83532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-03-09T01:39:35.835339Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"}
{"level":"info","ts":"2026-03-09T01:39:35.835401Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"}
{"level":"warn","ts":"2026-03-09T01:39:35.844818Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-03-09T01:39:35.849042Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-03-09T01:39:35.850181Z","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-03-09T01:39:35.852325Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-03-09T01:39:35.852424Z","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-03-09T01:39:35.852502Z","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-03-09T01:39:35.852522Z","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-03-09T01:39:35.853302Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-03-09T01:39:35.854494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"}
{"level":"info","ts":"2026-03-09T01:39:35.854774Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]}
{"level":"info","ts":"2026-03-09T01:39:35.857649Z","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-03-09T01:39:35.857898Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-03-09T01:39:35.857945Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-03-09T01:39:35.858075Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"}
{"level":"info","ts":"2026-03-09T01:39:35.858124Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"}
{"level":"info","ts":"2026-03-09T01:39:36.037229Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"}
{"level":"info","ts":"2026-03-09T01:39:36.037324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"}
{"level":"info","ts":"2026-03-09T01:39:36.037348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"}
{"level":"info","ts":"2026-03-09T01:39:36.037368Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"}
{"level":"info","ts":"2026-03-09T01:39:36.037379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"}
{"level":"info","ts":"2026-03-09T01:39:36.037395Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"}
{"level":"info","ts":"2026-03-09T01:39:36.037408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"}
{"level":"info","ts":"2026-03-09T01:39:36.038371Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:39:36.039199Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T01:39:36.039191Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"}
{"level":"info","ts":"2026-03-09T01:39:36.039233Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-03-09T01:39:36.039654Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-03-09T01:39:36.039682Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-03-09T01:39:36.039676Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:39:36.039794Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:39:36.039838Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-03-09T01:39:36.042614Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"}
{"level":"info","ts":"2026-03-09T01:39:36.0435Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"warn","ts":"2026-03-09T01:39:39.371824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.742421ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356763907148684534 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/system:aggregate-to-edit\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:aggregate-to-edit\" value_size:1957 >> failure:<>>","response":"size:14"}
{"level":"info","ts":"2026-03-09T01:39:39.371942Z","caller":"traceutil/trace.go:171","msg":"trace[1261903025] linearizableReadLoop","detail":"{readStateIndex:87; appliedIndex:86; }","duration":"810.259601ms","start":"2026-03-09T01:39:38.561666Z","end":"2026-03-09T01:39:39.371926Z","steps":["trace[1261903025] 'read index received'  (duration: 242.775053ms)","trace[1261903025] 'applied index is now lower than readState.Index'  (duration: 567.483308ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:39:39.372075Z","caller":"traceutil/trace.go:171","msg":"trace[958016157] transaction","detail":"{read_only:false; response_revision:83; number_of_response:1; }","duration":"844.410907ms","start":"2026-03-09T01:39:38.527627Z","end":"2026-03-09T01:39:39.372038Z","steps":["trace[958016157] 'process raft request'  (duration: 276.905719ms)","trace[958016157] 'compare'  (duration: 566.620988ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:39:39.37254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:39:38.527602Z","time spent":"844.851917ms","remote":"127.0.0.1:60956","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2012,"response count":0,"response size":37,"request content":"compare:<target:MOD key:\"/registry/clusterroles/system:aggregate-to-edit\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/system:aggregate-to-edit\" value_size:1957 >> failure:<>"}
{"level":"warn","ts":"2026-03-09T01:39:39.372114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"810.418384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"}
{"level":"info","ts":"2026-03-09T01:39:39.37271Z","caller":"traceutil/trace.go:171","msg":"trace[242119303] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:83; }","duration":"811.070598ms","start":"2026-03-09T01:39:38.561611Z","end":"2026-03-09T01:39:39.372682Z","steps":["trace[242119303] 'agreement among raft nodes before linearized reading'  (duration: 810.367083ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:39:39.372782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:39:38.561571Z","time spent":"811.195041ms","remote":"127.0.0.1:60660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2026-03-09T01:39:39.649662Z","caller":"traceutil/trace.go:171","msg":"trace[1397725602] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"270.447298ms","start":"2026-03-09T01:39:39.37917Z","end":"2026-03-09T01:39:39.649618Z","steps":["trace[1397725602] 'process raft request'  (duration: 265.717544ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:40:15.541924Z","caller":"traceutil/trace.go:171","msg":"trace[1603379756] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"269.966631ms","start":"2026-03-09T01:40:15.271931Z","end":"2026-03-09T01:40:15.541897Z","steps":["trace[1603379756] 'process raft request'  (duration: 269.783227ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:40:16.18663Z","caller":"traceutil/trace.go:171","msg":"trace[1463845388] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"319.023526ms","start":"2026-03-09T01:40:15.867582Z","end":"2026-03-09T01:40:16.186605Z","steps":["trace[1463845388] 'process raft request'  (duration: 318.855512ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:40:16.186988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:40:15.867559Z","time spent":"319.145228ms","remote":"127.0.0.1:60882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/kube-scheduler\" mod_revision:531 > success:<request_put:<key:\"/registry/leases/kube-system/kube-scheduler\" value_size:413 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-scheduler\" > >"}
{"level":"info","ts":"2026-03-09T01:40:33.160871Z","caller":"traceutil/trace.go:171","msg":"trace[1090597953] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"106.345998ms","start":"2026-03-09T01:40:33.054493Z","end":"2026-03-09T01:40:33.160839Z","steps":["trace[1090597953] 'process raft request'  (duration: 106.138784ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:40:55.506672Z","caller":"traceutil/trace.go:171","msg":"trace[1742821161] linearizableReadLoop","detail":"{readStateIndex:812; appliedIndex:811; }","duration":"208.089001ms","start":"2026-03-09T01:40:55.298556Z","end":"2026-03-09T01:40:55.506645Z","steps":["trace[1742821161] 'read index received'  (duration: 207.897727ms)","trace[1742821161] 'applied index is now lower than readState.Index'  (duration: 190.244µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:40:55.506797Z","caller":"traceutil/trace.go:171","msg":"trace[1027701154] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"213.955078ms","start":"2026-03-09T01:40:55.29283Z","end":"2026-03-09T01:40:55.506785Z","steps":["trace[1027701154] 'process raft request'  (duration: 213.651641ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:40:55.506968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.398768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:40:55.507049Z","caller":"traceutil/trace.go:171","msg":"trace[1302082680] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:783; }","duration":"208.519341ms","start":"2026-03-09T01:40:55.29851Z","end":"2026-03-09T01:40:55.50703Z","steps":["trace[1302082680] 'agreement among raft nodes before linearized reading'  (duration: 208.395348ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:40:55.668981Z","caller":"traceutil/trace.go:171","msg":"trace[484864305] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:812; }","duration":"162.206179ms","start":"2026-03-09T01:40:55.506748Z","end":"2026-03-09T01:40:55.668954Z","steps":["trace[484864305] 'read index received'  (duration: 120.179778ms)","trace[484864305] 'applied index is now lower than readState.Index'  (duration: 42.024631ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:40:55.6692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.957013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:40:55.669288Z","caller":"traceutil/trace.go:171","msg":"trace[1822925911] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:783; }","duration":"287.133247ms","start":"2026-03-09T01:40:55.382133Z","end":"2026-03-09T01:40:55.669266Z","steps":["trace[1822925911] 'agreement among raft nodes before linearized reading'  (duration: 286.937263ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:40:55.669292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.313353ms","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-03-09T01:40:55.669354Z","caller":"traceutil/trace.go:171","msg":"trace[166337606] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:783; }","duration":"207.416966ms","start":"2026-03-09T01:40:55.461914Z","end":"2026-03-09T01:40:55.669331Z","steps":["trace[166337606] 'agreement among raft nodes before linearized reading'  (duration: 207.060308ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:40:55.669531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.518943ms","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-03-09T01:40:55.669585Z","caller":"traceutil/trace.go:171","msg":"trace[1210048435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:783; }","duration":"295.650466ms","start":"2026-03-09T01:40:55.373921Z","end":"2026-03-09T01:40:55.669571Z","steps":["trace[1210048435] 'agreement among raft nodes before linearized reading'  (duration: 295.165885ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:40:56.64576Z","caller":"traceutil/trace.go:171","msg":"trace[330388774] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"257.086725ms","start":"2026-03-09T01:40:56.388646Z","end":"2026-03-09T01:40:56.645733Z","steps":["trace[330388774] 'process raft request'  (duration: 256.933842ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:25.012294Z","caller":"traceutil/trace.go:171","msg":"trace[957765422] linearizableReadLoop","detail":"{readStateIndex:967; appliedIndex:966; }","duration":"273.700035ms","start":"2026-03-09T01:41:24.738572Z","end":"2026-03-09T01:41:25.012272Z","steps":["trace[957765422] 'read index received'  (duration: 273.532311ms)","trace[957765422] 'applied index is now lower than readState.Index'  (duration: 166.523µs)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:41:25.012587Z","caller":"traceutil/trace.go:171","msg":"trace[1879010089] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"330.976292ms","start":"2026-03-09T01:41:24.681599Z","end":"2026-03-09T01:41:25.012575Z","steps":["trace[1879010089] 'process raft request'  (duration: 330.562492ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:25.01269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:24.681577Z","time spent":"331.046534ms","remote":"127.0.0.1:60882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-node-lease/instance\" mod_revision:902 > success:<request_put:<key:\"/registry/leases/kube-node-lease/instance\" value_size:472 >> failure:<request_range:<key:\"/registry/leases/kube-node-lease/instance\" > >"}
{"level":"warn","ts":"2026-03-09T01:41:25.012877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.312118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:41:25.012918Z","caller":"traceutil/trace.go:171","msg":"trace[1605419479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:930; }","duration":"274.3879ms","start":"2026-03-09T01:41:24.738519Z","end":"2026-03-09T01:41:25.012907Z","steps":["trace[1605419479] 'agreement among raft nodes before linearized reading'  (duration: 274.330299ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:25.013131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.16382ms","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-03-09T01:41:25.013168Z","caller":"traceutil/trace.go:171","msg":"trace[1119565818] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:930; }","duration":"213.236431ms","start":"2026-03-09T01:41:24.799923Z","end":"2026-03-09T01:41:25.013159Z","steps":["trace[1119565818] 'agreement among raft nodes before linearized reading'  (duration: 213.132759ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:37.699339Z","caller":"traceutil/trace.go:171","msg":"trace[1962433951] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"128.038862ms","start":"2026-03-09T01:41:37.571282Z","end":"2026-03-09T01:41:37.699321Z","steps":["trace[1962433951] 'process raft request'  (duration: 127.632851ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:41.180773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.885311ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356763907148686502 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c06da06b95\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c06da06b95\" value_size:703 lease:8133391870293910344 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-09T01:41:41.180928Z","caller":"traceutil/trace.go:171","msg":"trace[1866349830] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"310.688927ms","start":"2026-03-09T01:41:40.870187Z","end":"2026-03-09T01:41:41.180876Z","steps":["trace[1866349830] 'process raft request'  (duration: 169.632922ms)","trace[1866349830] 'compare'  (duration: 140.767838ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:41:41.180985Z","caller":"traceutil/trace.go:171","msg":"trace[324959975] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1039; }","duration":"256.419959ms","start":"2026-03-09T01:41:40.924557Z","end":"2026-03-09T01:41:41.180977Z","steps":["trace[324959975] 'read index received'  (duration: 115.276222ms)","trace[324959975] 'applied index is now lower than readState.Index'  (duration: 141.142957ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:41:41.181095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:40.870162Z","time spent":"310.852411ms","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":808,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c06da06b95\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c06da06b95\" value_size:703 lease:8133391870293910344 >> failure:<>"}
{"level":"warn","ts":"2026-03-09T01:41:41.181294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.729188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:41:41.181334Z","caller":"traceutil/trace.go:171","msg":"trace[1061824259] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:0; response_revision:1000; }","duration":"256.795819ms","start":"2026-03-09T01:41:40.924527Z","end":"2026-03-09T01:41:41.181323Z","steps":["trace[1061824259] 'agreement among raft nodes before linearized reading'  (duration: 256.734338ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:41.180952Z","caller":"traceutil/trace.go:171","msg":"trace[989572164] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"146.522122ms","start":"2026-03-09T01:41:41.034417Z","end":"2026-03-09T01:41:41.180939Z","steps":["trace[989572164] 'process raft request'  (duration: 146.457611ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:41.181531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.521663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-03-09T01:41:41.181569Z","caller":"traceutil/trace.go:171","msg":"trace[96453450] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1000; }","duration":"217.586474ms","start":"2026-03-09T01:41:40.963973Z","end":"2026-03-09T01:41:41.18156Z","steps":["trace[96453450] 'agreement among raft nodes before linearized reading'  (duration: 217.511772ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:41.364301Z","caller":"traceutil/trace.go:171","msg":"trace[223462779] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"177.62539ms","start":"2026-03-09T01:41:41.186647Z","end":"2026-03-09T01:41:41.364272Z","steps":["trace[223462779] 'process raft request'  (duration: 156.480795ms)","trace[223462779] 'compare'  (duration: 20.93174ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:41:41.366425Z","caller":"traceutil/trace.go:171","msg":"trace[1099903624] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"177.569479ms","start":"2026-03-09T01:41:41.188831Z","end":"2026-03-09T01:41:41.366401Z","steps":["trace[1099903624] 'process raft request'  (duration: 177.427315ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:41.366733Z","caller":"traceutil/trace.go:171","msg":"trace[1467689927] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"177.944058ms","start":"2026-03-09T01:41:41.188541Z","end":"2026-03-09T01:41:41.366486Z","steps":["trace[1467689927] 'process raft request'  (duration: 177.60345ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:42.02256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.719453ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356763907148686537 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c09af9bc86\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c09af9bc86\" value_size:693 lease:8133391870293910344 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-03-09T01:41:42.022826Z","caller":"traceutil/trace.go:171","msg":"trace[800371220] linearizableReadLoop","detail":"{readStateIndex:1063; appliedIndex:1061; }","duration":"304.550005ms","start":"2026-03-09T01:41:41.718261Z","end":"2026-03-09T01:41:42.022811Z","steps":["trace[800371220] 'read index received'  (duration: 66.410502ms)","trace[800371220] 'applied index is now lower than readState.Index'  (duration: 238.138543ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:41:42.022864Z","caller":"traceutil/trace.go:171","msg":"trace[1598717038] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"383.10343ms","start":"2026-03-09T01:41:41.639732Z","end":"2026-03-09T01:41:42.022835Z","steps":["trace[1598717038] 'process raft request'  (duration: 382.946516ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:42.022855Z","caller":"traceutil/trace.go:171","msg":"trace[1303927568] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"392.49279ms","start":"2026-03-09T01:41:41.630333Z","end":"2026-03-09T01:41:42.022826Z","steps":["trace[1303927568] 'process raft request'  (duration: 154.423168ms)","trace[1303927568] 'compare'  (duration: 237.482598ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:41:42.022992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.725969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"}
{"level":"warn","ts":"2026-03-09T01:41:42.023004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:41.630315Z","time spent":"392.614512ms","remote":"127.0.0.1:60708","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":798,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c09af9bc86\" mod_revision:0 > success:<request_put:<key:\"/registry/events/kube-system/ceph-csi-rbd-provisioner-6f6497f79c-6pmwr.189b08c09af9bc86\" value_size:693 lease:8133391870293910344 >> failure:<>"}
{"level":"info","ts":"2026-03-09T01:41:42.023028Z","caller":"traceutil/trace.go:171","msg":"trace[824385938] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1022; }","duration":"304.798171ms","start":"2026-03-09T01:41:41.718219Z","end":"2026-03-09T01:41:42.023017Z","steps":["trace[824385938] 'agreement among raft nodes before linearized reading'  (duration: 304.682448ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:42.023034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:41.639719Z","time spent":"383.201383ms","remote":"127.0.0.1:60882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" mod_revision:1017 > success:<request_put:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" > >"}
{"level":"warn","ts":"2026-03-09T01:41:42.023058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:41.718197Z","time spent":"304.854313ms","remote":"127.0.0.1:60882","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":"info","ts":"2026-03-09T01:41:42.178365Z","caller":"traceutil/trace.go:171","msg":"trace[1845682584] transaction","detail":"{read_only:false; response_revision:1023; number_of_response:1; }","duration":"151.191351ms","start":"2026-03-09T01:41:42.027136Z","end":"2026-03-09T01:41:42.178328Z","steps":["trace[1845682584] 'process raft request'  (duration: 120.73588ms)","trace[1845682584] 'compare'  (duration: 30.228445ms)"],"step_count":2}
{"level":"info","ts":"2026-03-09T01:41:42.17857Z","caller":"traceutil/trace.go:171","msg":"trace[1503006842] transaction","detail":"{read_only:false; response_revision:1024; number_of_response:1; }","duration":"151.399917ms","start":"2026-03-09T01:41:42.027128Z","end":"2026-03-09T01:41:42.178528Z","steps":["trace[1503006842] 'process raft request'  (duration: 151.13223ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:42.189957Z","caller":"traceutil/trace.go:171","msg":"trace[384005501] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"162.539617ms","start":"2026-03-09T01:41:42.027397Z","end":"2026-03-09T01:41:42.189937Z","steps":["trace[384005501] 'process raft request'  (duration: 162.418364ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:42.19024Z","caller":"traceutil/trace.go:171","msg":"trace[1163248916] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"162.474895ms","start":"2026-03-09T01:41:42.027744Z","end":"2026-03-09T01:41:42.190219Z","steps":["trace[1163248916] 'process raft request'  (duration: 162.150238ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:43.063274Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.866659ms","expected-duration":"100ms","prefix":"","request":"header:<ID:17356763907148686548 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-z6v6h\" mod_revision:834 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-z6v6h\" value_size:1432 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-z6v6h\" > >>","response":"size:16"}
{"level":"info","ts":"2026-03-09T01:41:43.063387Z","caller":"traceutil/trace.go:171","msg":"trace[393038688] transaction","detail":"{read_only:false; response_revision:1028; number_of_response:1; }","duration":"344.889607ms","start":"2026-03-09T01:41:42.718473Z","end":"2026-03-09T01:41:43.063363Z","steps":["trace[393038688] 'process raft request'  (duration: 13.824923ms)","trace[393038688] 'compare'  (duration: 330.558082ms)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:41:43.063465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:42.718451Z","time spent":"344.974419ms","remote":"127.0.0.1:60886","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1520,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-z6v6h\" mod_revision:834 > success:<request_put:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-z6v6h\" value_size:1432 >> failure:<request_range:<key:\"/registry/endpointslices/kube-system/ceph-csi-rbd-provisioner-http-metrics-z6v6h\" > >"}
{"level":"info","ts":"2026-03-09T01:41:43.06479Z","caller":"traceutil/trace.go:171","msg":"trace[165657043] linearizableReadLoop","detail":"{readStateIndex:1071; appliedIndex:1069; }","duration":"327.819648ms","start":"2026-03-09T01:41:42.736949Z","end":"2026-03-09T01:41:43.064768Z","steps":["trace[165657043] 'read index received'  (duration: 327.387969ms)","trace[165657043] 'applied index is now lower than readState.Index'  (duration: 430.689µs)"],"step_count":2}
{"level":"warn","ts":"2026-03-09T01:41:43.064938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.987242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-03-09T01:41:43.064964Z","caller":"traceutil/trace.go:171","msg":"trace[206147465] transaction","detail":"{read_only:false; response_revision:1030; number_of_response:1; }","duration":"343.124996ms","start":"2026-03-09T01:41:42.72181Z","end":"2026-03-09T01:41:43.064935Z","steps":["trace[206147465] 'process raft request'  (duration: 342.754328ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:43.064996Z","caller":"traceutil/trace.go:171","msg":"trace[333846726] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1030; }","duration":"328.043883ms","start":"2026-03-09T01:41:42.736934Z","end":"2026-03-09T01:41:43.064978Z","steps":["trace[333846726] 'agreement among raft nodes before linearized reading'  (duration: 327.941201ms)"],"step_count":1}
{"level":"info","ts":"2026-03-09T01:41:43.064981Z","caller":"traceutil/trace.go:171","msg":"trace[250180482] transaction","detail":"{read_only:false; response_revision:1029; number_of_response:1; }","duration":"345.537502ms","start":"2026-03-09T01:41:42.719422Z","end":"2026-03-09T01:41:43.064959Z","steps":["trace[250180482] 'process raft request'  (duration: 344.991779ms)"],"step_count":1}
{"level":"warn","ts":"2026-03-09T01:41:43.065042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:42.736871Z","time spent":"328.159706ms","remote":"127.0.0.1:60660","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-03-09T01:41:43.065131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:42.721801Z","time spent":"343.224558ms","remote":"127.0.0.1:32864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10202,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-6f6497f79c\" mod_revision:857 > success:<request_put:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-6f6497f79c\" value_size:10125 >> failure:<request_range:<key:\"/registry/replicasets/kube-system/ceph-csi-rbd-provisioner-6f6497f79c\" > >"}
{"level":"warn","ts":"2026-03-09T01:41:43.065134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-09T01:41:42.719413Z","time spent":"345.629254ms","remote":"127.0.0.1:60786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":925,"response count":0,"response size":39,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" mod_revision:833 > success:<request_put:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" value_size:839 >> failure:<request_range:<key:\"/registry/services/endpoints/kube-system/ceph-csi-rbd-provisioner-http-metrics\" > >"}