{"level":"warn","ts":"2026-05-30T16:48:26.987666Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T16:48:26.987754Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.25: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.25:2380","--initial-cluster=instance=https://199.204.45.25:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.25:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.25: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-05-30T16:48:26.987817Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T16:48:26.987829Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-05-30T16:48:26.987845Z","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-05-30T16:48:26.988442Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"]} {"level":"info","ts":"2026-05-30T16:48:26.988509Z","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.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.25: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-05-30T16:48:26.991859Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.151786ms"} {"level":"info","ts":"2026-05-30T16:48:26.996801Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"ba52c55cf4193752","cluster-id":"4468ed52294bc271"} {"level":"info","ts":"2026-05-30T16:48:26.996872Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T16:48:26.996891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 0"} {"level":"info","ts":"2026-05-30T16:48:26.996906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ba52c55cf4193752 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T16:48:26.996915Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became follower at term 1"} {"level":"info","ts":"2026-05-30T16:48:26.996951Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"warn","ts":"2026-05-30T16:48:27.002399Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T16:48:27.003603Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T16:48:27.004651Z","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-05-30T16:48:27.007464Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"ba52c55cf4193752","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T16:48:27.007666Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"ba52c55cf4193752","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T16:48:27.007929Z","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-05-30T16:48:27.008026Z","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-05-30T16:48:27.008096Z","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-05-30T16:48:27.008816Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 switched to configuration voters=(13426010442167826258)"} {"level":"info","ts":"2026-05-30T16:48:27.009132Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","added-peer-id":"ba52c55cf4193752","added-peer-peer-urls":["https://199.204.45.25:2380"]} {"level":"info","ts":"2026-05-30T16:48:27.012767Z","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-05-30T16:48:27.012839Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-30T16:48:27.012883Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.25:2380"} {"level":"info","ts":"2026-05-30T16:48:27.013064Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"ba52c55cf4193752","initial-advertise-peer-urls":["https://199.204.45.25:2380"],"listen-peer-urls":["https://199.204.45.25:2380"],"advertise-client-urls":["https://199.204.45.25:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.25:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T16:48:27.013109Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T16:48:27.097953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T16:48:27.098013Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T16:48:27.098032Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgPreVoteResp from ba52c55cf4193752 at term 1"} {"level":"info","ts":"2026-05-30T16:48:27.098052Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became candidate at term 2"} {"level":"info","ts":"2026-05-30T16:48:27.098063Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 received MsgVoteResp from ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-30T16:48:27.098095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ba52c55cf4193752 became leader at term 2"} {"level":"info","ts":"2026-05-30T16:48:27.098106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ba52c55cf4193752 elected leader ba52c55cf4193752 at term 2"} {"level":"info","ts":"2026-05-30T16:48:27.099847Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T16:48:27.100419Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T16:48:27.100422Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"ba52c55cf4193752","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.25:2379]}","request-path":"/0/members/ba52c55cf4193752/attributes","cluster-id":"4468ed52294bc271","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T16:48:27.100612Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T16:48:27.100636Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T16:48:27.100557Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T16:48:27.102888Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.25:2379"} {"level":"info","ts":"2026-05-30T16:48:27.103845Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4468ed52294bc271","local-member-id":"ba52c55cf4193752","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T16:48:27.104082Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T16:48:27.104223Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T16:48:27.105062Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T16:48:44.751579Z","caller":"traceutil/trace.go:171","msg":"trace[1913886083] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"113.387941ms","start":"2026-05-30T16:48:44.638151Z","end":"2026-05-30T16:48:44.751539Z","steps":["trace[1913886083] 'process raft request' (duration: 113.175148ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:49:05.627237Z","caller":"traceutil/trace.go:171","msg":"trace[2092889685] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"225.774573ms","start":"2026-05-30T16:49:05.401435Z","end":"2026-05-30T16:49:05.627209Z","steps":["trace[2092889685] 'process raft request' (duration: 224.030962ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:49:05.63219Z","caller":"traceutil/trace.go:171","msg":"trace[476644095] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"169.890087ms","start":"2026-05-30T16:49:05.462271Z","end":"2026-05-30T16:49:05.632161Z","steps":["trace[476644095] 'process raft request' (duration: 169.643843ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:49:56.409956Z","caller":"traceutil/trace.go:171","msg":"trace[147830377] transaction","detail":"{read_only:false; response_revision:954; number_of_response:1; }","duration":"220.617332ms","start":"2026-05-30T16:49:56.189324Z","end":"2026-05-30T16:49:56.409941Z","steps":["trace[147830377] 'process raft request' (duration: 220.470169ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:25.560665Z","caller":"traceutil/trace.go:171","msg":"trace[1173978859] transaction","detail":"{read_only:false; response_revision:1052; number_of_response:1; }","duration":"335.61937ms","start":"2026-05-30T16:50:25.225012Z","end":"2026-05-30T16:50:25.560632Z","steps":["trace[1173978859] 'process raft request' (duration: 335.447827ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T16:50:25.561418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T16:50:25.225002Z","time spent":"335.842945ms","remote":"127.0.0.1:35300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T16:50:25.587771Z","caller":"traceutil/trace.go:171","msg":"trace[2032077678] linearizableReadLoop","detail":"{readStateIndex:1093; appliedIndex:1091; }","duration":"156.74796ms","start":"2026-05-30T16:50:25.431002Z","end":"2026-05-30T16:50:25.58775Z","steps":["trace[2032077678] 'read index received' (duration: 129.368339ms)","trace[2032077678] 'applied index is now lower than readState.Index' (duration: 27.378711ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T16:50:25.587851Z","caller":"traceutil/trace.go:171","msg":"trace[1469025481] transaction","detail":"{read_only:false; response_revision:1053; number_of_response:1; }","duration":"362.491961ms","start":"2026-05-30T16:50:25.225325Z","end":"2026-05-30T16:50:25.587817Z","steps":["trace[1469025481] 'process raft request' (duration: 362.304958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T16:50:25.587976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.567278ms","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-05-30T16:50:25.588037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.297478ms","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-05-30T16:50:25.588058Z","caller":"traceutil/trace.go:171","msg":"trace[986456900] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1053; }","duration":"144.68946ms","start":"2026-05-30T16:50:25.443359Z","end":"2026-05-30T16:50:25.588048Z","steps":["trace[986456900] 'agreement among raft nodes before linearized reading' (duration: 144.512727ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T16:50:25.588048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.018445ms","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-05-30T16:50:25.588093Z","caller":"traceutil/trace.go:171","msg":"trace[442895479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1053; }","duration":"108.39097ms","start":"2026-05-30T16:50:25.47969Z","end":"2026-05-30T16:50:25.588081Z","steps":["trace[442895479] 'agreement among raft nodes before linearized reading' (duration: 108.202277ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:25.588146Z","caller":"traceutil/trace.go:171","msg":"trace[844048470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1053; }","duration":"157.162468ms","start":"2026-05-30T16:50:25.43096Z","end":"2026-05-30T16:50:25.588122Z","steps":["trace[844048470] 'agreement among raft nodes before linearized reading' (duration: 156.880513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T16:50:25.588014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T16:50:25.225311Z","time spent":"362.614073ms","remote":"127.0.0.1:35300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T16:50:26.902548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.933685ms","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-05-30T16:50:26.902738Z","caller":"traceutil/trace.go:171","msg":"trace[2145150250] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1057; }","duration":"116.275281ms","start":"2026-05-30T16:50:26.78643Z","end":"2026-05-30T16:50:26.902705Z","steps":["trace[2145150250] 'count revisions from in-memory index tree' (duration: 115.768821ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:30.792728Z","caller":"traceutil/trace.go:171","msg":"trace[1994653178] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"213.447367ms","start":"2026-05-30T16:50:30.579249Z","end":"2026-05-30T16:50:30.792697Z","steps":["trace[1994653178] 'process raft request' (duration: 213.224733ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:41.770504Z","caller":"traceutil/trace.go:171","msg":"trace[930607350] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1201; }","duration":"100.602973ms","start":"2026-05-30T16:50:41.669869Z","end":"2026-05-30T16:50:41.770472Z","steps":["trace[930607350] 'read index received' (duration: 42.935876ms)","trace[930607350] 'applied index is now lower than readState.Index' (duration: 57.666147ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T16:50:41.770629Z","caller":"traceutil/trace.go:171","msg":"trace[1760205609] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"126.953933ms","start":"2026-05-30T16:50:41.643652Z","end":"2026-05-30T16:50:41.770606Z","steps":["trace[1760205609] 'process raft request' (duration: 69.165344ms)","trace[1760205609] 'compare' (duration: 57.541715ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T16:50:41.770836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.942379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-05-30T16:50:41.770893Z","caller":"traceutil/trace.go:171","msg":"trace[969582564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1156; }","duration":"101.01754ms","start":"2026-05-30T16:50:41.669857Z","end":"2026-05-30T16:50:41.770875Z","steps":["trace[969582564] 'agreement among raft nodes before linearized reading' (duration: 100.794426ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:57.578557Z","caller":"traceutil/trace.go:171","msg":"trace[227187583] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"207.639588ms","start":"2026-05-30T16:50:57.370898Z","end":"2026-05-30T16:50:57.578537Z","steps":["trace[227187583] 'process raft request' (duration: 207.488805ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:57.793792Z","caller":"traceutil/trace.go:171","msg":"trace[2128433922] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"201.172425ms","start":"2026-05-30T16:50:57.592589Z","end":"2026-05-30T16:50:57.793761Z","steps":["trace[2128433922] 'process raft request' (duration: 201.091524ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:57.793831Z","caller":"traceutil/trace.go:171","msg":"trace[1011590033] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"208.493954ms","start":"2026-05-30T16:50:57.585313Z","end":"2026-05-30T16:50:57.793807Z","steps":["trace[1011590033] 'process raft request' (duration: 208.106297ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T16:50:58.251153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.691195ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T16:50:58.251258Z","caller":"traceutil/trace.go:171","msg":"trace[1260651784] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1278; }","duration":"269.914222ms","start":"2026-05-30T16:50:57.981329Z","end":"2026-05-30T16:50:58.251243Z","steps":["trace[1260651784] 'read index received' (duration: 12.251963ms)","trace[1260651784] 'applied index is now lower than readState.Index' (duration: 257.661119ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T16:50:58.251411Z","caller":"traceutil/trace.go:171","msg":"trace[1633682829] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"297.536217ms","start":"2026-05-30T16:50:57.953825Z","end":"2026-05-30T16:50:58.251362Z","steps":["trace[1633682829] 'process raft request' (duration: 166.424234ms)","trace[1633682829] 'compare' (duration: 130.523582ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T16:50:58.251624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.289158ms","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-05-30T16:50:58.251656Z","caller":"traceutil/trace.go:171","msg":"trace[1357595938] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1231; }","duration":"270.354989ms","start":"2026-05-30T16:50:57.98129Z","end":"2026-05-30T16:50:58.251645Z","steps":["trace[1357595938] 'agreement among raft nodes before linearized reading' (duration: 270.226627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T16:50:58.251695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.265238ms","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-05-30T16:50:58.251757Z","caller":"traceutil/trace.go:171","msg":"trace[2220675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1231; }","duration":"270.37008ms","start":"2026-05-30T16:50:57.981369Z","end":"2026-05-30T16:50:58.251739Z","steps":["trace[2220675] 'agreement among raft nodes before linearized reading' (duration: 270.173516ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:58.443949Z","caller":"traceutil/trace.go:171","msg":"trace[1794737846] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"188.237879ms","start":"2026-05-30T16:50:58.255687Z","end":"2026-05-30T16:50:58.443925Z","steps":["trace[1794737846] 'process raft request' (duration: 180.496581ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:50:59.016595Z","caller":"traceutil/trace.go:171","msg":"trace[1592343172] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"123.352395ms","start":"2026-05-30T16:50:58.89321Z","end":"2026-05-30T16:50:59.016562Z","steps":["trace[1592343172] 'process raft request' (duration: 123.148832ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:51:11.630306Z","caller":"traceutil/trace.go:171","msg":"trace[761612029] transaction","detail":"{read_only:false; response_revision:1325; number_of_response:1; }","duration":"178.86973ms","start":"2026-05-30T16:51:11.451142Z","end":"2026-05-30T16:51:11.630011Z","steps":["trace[761612029] 'process raft request' (duration: 178.656436ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:54:59.191436Z","caller":"traceutil/trace.go:171","msg":"trace[944171856] linearizableReadLoop","detail":"{readStateIndex:2494; appliedIndex:2492; }","duration":"118.286022ms","start":"2026-05-30T16:54:59.073127Z","end":"2026-05-30T16:54:59.191413Z","steps":["trace[944171856] 'read index received' (duration: 57.808201ms)","trace[944171856] 'applied index is now lower than readState.Index' (duration: 60.477061ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T16:54:59.191647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.508057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-05-30T16:54:59.191685Z","caller":"traceutil/trace.go:171","msg":"trace[728393288] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2396; }","duration":"118.606079ms","start":"2026-05-30T16:54:59.073068Z","end":"2026-05-30T16:54:59.191674Z","steps":["trace[728393288] 'agreement among raft nodes before linearized reading' (duration: 118.445976ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T16:54:59.191689Z","caller":"traceutil/trace.go:171","msg":"trace[1148422484] transaction","detail":"{read_only:false; response_revision:2396; number_of_response:1; }","duration":"121.815289ms","start":"2026-05-30T16:54:59.069833Z","end":"2026-05-30T16:54:59.191648Z","steps":["trace[1148422484] 'process raft request' (duration: 121.470443ms)"],"step_count":1}