{"level":"warn","ts":"2026-04-20T05:49:44.893369Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T05:49:44.89347Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72: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.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72: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-04-20T05:49:44.89355Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T05:49:44.893564Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-04-20T05:49:44.89359Z","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-04-20T05:49:44.894219Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-04-20T05:49:44.894293Z","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.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72: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-04-20T05:49:44.898104Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.611433ms"} {"level":"info","ts":"2026-04-20T05:49:44.903843Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-04-20T05:49:44.903908Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T05:49:44.903936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-04-20T05:49:44.903953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T05:49:44.903996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-04-20T05:49:44.90409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-04-20T05:49:44.910598Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T05:49:44.911855Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T05:49:44.912894Z","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-04-20T05:49:44.915212Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T05:49:44.915454Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T05:49:44.91558Z","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-04-20T05:49:44.915692Z","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-04-20T05:49:44.915703Z","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-04-20T05:49:44.916632Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-04-20T05:49:44.917015Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-04-20T05:49:44.92056Z","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-04-20T05:49:44.920667Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-20T05:49:44.920726Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-04-20T05:49:44.920735Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T05:49:44.920768Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T05:49:45.804984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T05:49:45.805048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T05:49:45.805092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-04-20T05:49:45.805117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-04-20T05:49:45.805125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-20T05:49:45.805139Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-04-20T05:49:45.80515Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-04-20T05:49:45.806586Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T05:49:45.806591Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:49:45.806671Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:45.806638Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:49:45.806873Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T05:49:45.806968Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T05:49:45.811157Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:45.811339Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:45.811386Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:49:45.811712Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-04-20T05:49:45.813538Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T05:49:48.319179Z","caller":"traceutil/trace.go:171","msg":"trace[797596555] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"146.989018ms","start":"2026-04-20T05:49:48.172155Z","end":"2026-04-20T05:49:48.319144Z","steps":["trace[797596555] 'read index received' (duration: 141.094557ms)","trace[797596555] 'applied index is now lower than readState.Index' (duration: 5.893241ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:48.319354Z","caller":"traceutil/trace.go:171","msg":"trace[1856761932] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"243.335345ms","start":"2026-04-20T05:49:48.075963Z","end":"2026-04-20T05:49:48.319299Z","steps":["trace[1856761932] 'process raft request' (duration: 237.348171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:48.319484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.270425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T05:49:48.319564Z","caller":"traceutil/trace.go:171","msg":"trace[353023899] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:73; }","duration":"147.449589ms","start":"2026-04-20T05:49:48.1721Z","end":"2026-04-20T05:49:48.31955Z","steps":["trace[353023899] 'agreement among raft nodes before linearized reading' (duration: 147.179792ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:48.564539Z","caller":"traceutil/trace.go:171","msg":"trace[1113975368] transaction","detail":"{read_only:false; response_revision:86; number_of_response:1; }","duration":"171.903429ms","start":"2026-04-20T05:49:48.392562Z","end":"2026-04-20T05:49:48.564465Z","steps":["trace[1113975368] 'process raft request' (duration: 155.666821ms)","trace[1113975368] 'compare' (duration: 15.445277ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:50.002232Z","caller":"traceutil/trace.go:171","msg":"trace[1159758294] linearizableReadLoop","detail":"{readStateIndex:250; appliedIndex:249; }","duration":"178.456867ms","start":"2026-04-20T05:49:49.823743Z","end":"2026-04-20T05:49:50.0022Z","steps":["trace[1159758294] 'read index received' (duration: 178.225102ms)","trace[1159758294] 'applied index is now lower than readState.Index' (duration: 230.665µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:50.002439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.675143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:50.002483Z","caller":"traceutil/trace.go:171","msg":"trace[1026962698] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:244; }","duration":"178.790865ms","start":"2026-04-20T05:49:49.823682Z","end":"2026-04-20T05:49:50.002473Z","steps":["trace[1026962698] 'agreement among raft nodes before linearized reading' (duration: 178.707843ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:49:50.002601Z","caller":"traceutil/trace.go:171","msg":"trace[498682674] transaction","detail":"{read_only:false; response_revision:244; number_of_response:1; }","duration":"204.377813ms","start":"2026-04-20T05:49:49.79819Z","end":"2026-04-20T05:49:50.002568Z","steps":["trace[498682674] 'process raft request' (duration: 203.837859ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:50.420518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.081458ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:49:50.420643Z","caller":"traceutil/trace.go:171","msg":"trace[99503554] linearizableReadLoop","detail":"{readStateIndex:251; appliedIndex:250; }","duration":"415.013747ms","start":"2026-04-20T05:49:50.00561Z","end":"2026-04-20T05:49:50.420623Z","steps":["trace[99503554] 'read index received' (duration: 171.121598ms)","trace[99503554] 'applied index is now lower than readState.Index' (duration: 243.890909ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:50.420916Z","caller":"traceutil/trace.go:171","msg":"trace[319865131] transaction","detail":"{read_only:false; response_revision:245; number_of_response:1; }","duration":"416.31506ms","start":"2026-04-20T05:49:50.004588Z","end":"2026-04-20T05:49:50.420903Z","steps":["trace[319865131] 'process raft request' (duration: 172.257797ms)","trace[319865131] 'compare' (duration: 242.893204ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:49:50.420978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:50.004571Z","time spent":"416.381271ms","remote":"127.0.0.1:41022","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T05:49:50.421024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.163636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:50.421134Z","caller":"traceutil/trace.go:171","msg":"trace[1468617051] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:245; }","duration":"165.34433ms","start":"2026-04-20T05:49:50.255763Z","end":"2026-04-20T05:49:50.421108Z","steps":["trace[1468617051] 'agreement among raft nodes before linearized reading' (duration: 165.103634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:50.421031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.364976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-pycgar\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:49:50.421382Z","caller":"traceutil/trace.go:171","msg":"trace[2088707867] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-pycgar; range_end:; response_count:0; response_revision:245; }","duration":"415.737967ms","start":"2026-04-20T05:49:50.005575Z","end":"2026-04-20T05:49:50.421313Z","steps":["trace[2088707867] 'agreement among raft nodes before linearized reading' (duration: 415.330495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:50.421562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:49:50.005563Z","time spent":"415.939381ms","remote":"127.0.0.1:40902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-pycgar\" "} {"level":"warn","ts":"2026-04-20T05:50:15.63948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.541766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:50:15.639566Z","caller":"traceutil/trace.go:171","msg":"trace[951278488] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:509; }","duration":"130.688329ms","start":"2026-04-20T05:50:15.508856Z","end":"2026-04-20T05:50:15.639545Z","steps":["trace[951278488] 'range keys from in-memory index tree' (duration: 130.459604ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:16.138053Z","caller":"traceutil/trace.go:171","msg":"trace[1745810608] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"100.124354ms","start":"2026-04-20T05:50:16.037905Z","end":"2026-04-20T05:50:16.13803Z","steps":["trace[1745810608] 'process raft request' (duration: 52.674954ms)","trace[1745810608] 'compare' (duration: 47.293316ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:22.128219Z","caller":"traceutil/trace.go:171","msg":"trace[2143629609] linearizableReadLoop","detail":"{readStateIndex:635; appliedIndex:634; }","duration":"277.652147ms","start":"2026-04-20T05:50:21.850548Z","end":"2026-04-20T05:50:22.1282Z","steps":["trace[2143629609] 'read index received' (duration: 276.814846ms)","trace[2143629609] 'applied index is now lower than readState.Index' (duration: 836.421µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:50:22.128446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.771259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:50:22.128473Z","caller":"traceutil/trace.go:171","msg":"trace[1228747667] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"277.966944ms","start":"2026-04-20T05:50:21.850498Z","end":"2026-04-20T05:50:22.128465Z","steps":["trace[1228747667] 'agreement among raft nodes before linearized reading' (duration: 277.77738ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:22.128856Z","caller":"traceutil/trace.go:171","msg":"trace[1762546002] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"355.141008ms","start":"2026-04-20T05:50:21.773683Z","end":"2026-04-20T05:50:22.128824Z","steps":["trace[1762546002] 'process raft request' (duration: 354.094552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:22.12918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:21.773657Z","time spent":"355.280601ms","remote":"127.0.0.1:40902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:50:22.261323Z","caller":"traceutil/trace.go:171","msg":"trace[1575592014] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"132.202718ms","start":"2026-04-20T05:50:22.129098Z","end":"2026-04-20T05:50:22.261301Z","steps":["trace[1575592014] 'process raft request' (duration: 132.032594ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:22.851722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.177215ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:50:22.851827Z","caller":"traceutil/trace.go:171","msg":"trace[319045087] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"549.72646ms","start":"2026-04-20T05:50:22.302057Z","end":"2026-04-20T05:50:22.851783Z","steps":["trace[319045087] 'read index received' (duration: 321.431963ms)","trace[319045087] 'applied index is now lower than readState.Index' (duration: 228.293657ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:22.851946Z","caller":"traceutil/trace.go:171","msg":"trace[1964939874] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"556.183755ms","start":"2026-04-20T05:50:22.295753Z","end":"2026-04-20T05:50:22.851937Z","steps":["trace[1964939874] 'process raft request' (duration: 327.735514ms)","trace[1964939874] 'compare' (duration: 227.747913ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:50:22.852044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:22.295727Z","time spent":"556.260917ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:50:22.852237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.610456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T05:50:22.852343Z","caller":"traceutil/trace.go:171","msg":"trace[1103045232] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"279.776351ms","start":"2026-04-20T05:50:22.572546Z","end":"2026-04-20T05:50:22.852322Z","steps":["trace[1103045232] 'agreement among raft nodes before linearized reading' (duration: 279.550455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:22.852515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.460788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:50:22.852561Z","caller":"traceutil/trace.go:171","msg":"trace[417305568] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:620; }","duration":"550.5431ms","start":"2026-04-20T05:50:22.302003Z","end":"2026-04-20T05:50:22.852546Z","steps":["trace[417305568] 'agreement among raft nodes before linearized reading' (duration: 550.448498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:22.852601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:22.301984Z","time spent":"550.606121ms","remote":"127.0.0.1:41068","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"info","ts":"2026-04-20T05:51:37.421417Z","caller":"traceutil/trace.go:171","msg":"trace[1694480294] linearizableReadLoop","detail":"{readStateIndex:1109; appliedIndex:1108; }","duration":"214.059992ms","start":"2026-04-20T05:51:37.207331Z","end":"2026-04-20T05:51:37.421391Z","steps":["trace[1694480294] 'read index received' (duration: 213.894398ms)","trace[1694480294] 'applied index is now lower than readState.Index' (duration: 164.594µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:37.421483Z","caller":"traceutil/trace.go:171","msg":"trace[1392860270] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"221.424503ms","start":"2026-04-20T05:51:37.200017Z","end":"2026-04-20T05:51:37.421441Z","steps":["trace[1392860270] 'process raft request' (duration: 221.234458ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:37.421606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.262136ms","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-04-20T05:51:37.421645Z","caller":"traceutil/trace.go:171","msg":"trace[248012096] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1072; }","duration":"214.357029ms","start":"2026-04-20T05:51:37.207277Z","end":"2026-04-20T05:51:37.421634Z","steps":["trace[248012096] 'agreement among raft nodes before linearized reading' (duration: 214.216145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:45.890134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.881992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T05:51:45.890199Z","caller":"traceutil/trace.go:171","msg":"trace[258687179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1100; }","duration":"144.990315ms","start":"2026-04-20T05:51:45.745194Z","end":"2026-04-20T05:51:45.890185Z","steps":["trace[258687179] 'range keys from in-memory index tree' (duration: 144.766949ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:46.01919Z","caller":"traceutil/trace.go:171","msg":"trace[2084527139] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"124.92614ms","start":"2026-04-20T05:51:45.894244Z","end":"2026-04-20T05:51:46.01917Z","steps":["trace[2084527139] 'process raft request' (duration: 124.820238ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:46.02706Z","caller":"traceutil/trace.go:171","msg":"trace[999203577] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"131.863402ms","start":"2026-04-20T05:51:45.895175Z","end":"2026-04-20T05:51:46.027038Z","steps":["trace[999203577] 'process raft request' (duration: 131.526534ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:47.023288Z","caller":"traceutil/trace.go:171","msg":"trace[168694069] linearizableReadLoop","detail":"{readStateIndex:1143; appliedIndex:1142; }","duration":"169.667771ms","start":"2026-04-20T05:51:46.853558Z","end":"2026-04-20T05:51:47.023226Z","steps":["trace[168694069] 'read index received' (duration: 169.290051ms)","trace[168694069] 'applied index is now lower than readState.Index' (duration: 376.54µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:51:47.023462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.883436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:51:47.023493Z","caller":"traceutil/trace.go:171","msg":"trace[897274790] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1104; }","duration":"169.99743ms","start":"2026-04-20T05:51:46.853485Z","end":"2026-04-20T05:51:47.023483Z","steps":["trace[897274790] 'agreement among raft nodes before linearized reading' (duration: 169.906327ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:47.023647Z","caller":"traceutil/trace.go:171","msg":"trace[318944625] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"416.852227ms","start":"2026-04-20T05:51:46.606749Z","end":"2026-04-20T05:51:47.023601Z","steps":["trace[318944625] 'process raft request' (duration: 416.253413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:47.02391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:46.606723Z","time spent":"417.070742ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:51:48.315769Z","caller":"traceutil/trace.go:171","msg":"trace[1962231431] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1145; }","duration":"284.887974ms","start":"2026-04-20T05:51:48.030856Z","end":"2026-04-20T05:51:48.315744Z","steps":["trace[1962231431] 'read index received' (duration: 284.711889ms)","trace[1962231431] 'applied index is now lower than readState.Index' (duration: 174.895µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:48.315914Z","caller":"traceutil/trace.go:171","msg":"trace[1888167983] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"288.609795ms","start":"2026-04-20T05:51:48.027268Z","end":"2026-04-20T05:51:48.315877Z","steps":["trace[1888167983] 'process raft request' (duration: 288.305788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:48.316231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.349545ms","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-04-20T05:51:48.316292Z","caller":"traceutil/trace.go:171","msg":"trace[363615150] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1107; }","duration":"285.460938ms","start":"2026-04-20T05:51:48.030816Z","end":"2026-04-20T05:51:48.316277Z","steps":["trace[363615150] 'agreement among raft nodes before linearized reading' (duration: 285.047778ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:48.339289Z","caller":"traceutil/trace.go:171","msg":"trace[2022203263] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"308.144614ms","start":"2026-04-20T05:51:48.031117Z","end":"2026-04-20T05:51:48.339262Z","steps":["trace[2022203263] 'process raft request' (duration: 308.032052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:48.339393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.131405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:51:48.339438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:48.031107Z","time spent":"308.255198ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:51:48.339465Z","caller":"traceutil/trace.go:171","msg":"trace[472129362] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1108; }","duration":"127.257898ms","start":"2026-04-20T05:51:48.21219Z","end":"2026-04-20T05:51:48.339448Z","steps":["trace[472129362] 'agreement among raft nodes before linearized reading' (duration: 127.068393ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:19.783984Z","caller":"traceutil/trace.go:171","msg":"trace[484852828] linearizableReadLoop","detail":"{readStateIndex:1346; appliedIndex:1345; }","duration":"126.636684ms","start":"2026-04-20T05:52:19.65733Z","end":"2026-04-20T05:52:19.783967Z","steps":["trace[484852828] 'read index received' (duration: 126.539442ms)","trace[484852828] 'applied index is now lower than readState.Index' (duration: 96.062µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:52:19.784013Z","caller":"traceutil/trace.go:171","msg":"trace[1238405002] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"142.19057ms","start":"2026-04-20T05:52:19.641798Z","end":"2026-04-20T05:52:19.783988Z","steps":["trace[1238405002] 'process raft request' (duration: 142.067467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:19.784296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.952142ms","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-04-20T05:52:19.784386Z","caller":"traceutil/trace.go:171","msg":"trace[301483932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1298; }","duration":"127.033424ms","start":"2026-04-20T05:52:19.657286Z","end":"2026-04-20T05:52:19.78432Z","steps":["trace[301483932] 'agreement among raft nodes before linearized reading' (duration: 126.772588ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:20.142108Z","caller":"traceutil/trace.go:171","msg":"trace[170584278] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"299.154365ms","start":"2026-04-20T05:52:19.842923Z","end":"2026-04-20T05:52:20.142077Z","steps":["trace[170584278] 'process raft request' (duration: 252.278104ms)","trace[170584278] 'compare' (duration: 46.603264ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:52:20.162138Z","caller":"traceutil/trace.go:171","msg":"trace[637105758] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"284.83397ms","start":"2026-04-20T05:52:19.877281Z","end":"2026-04-20T05:52:20.162115Z","steps":["trace[637105758] 'process raft request' (duration: 284.741597ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:20.893977Z","caller":"traceutil/trace.go:171","msg":"trace[731406269] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"264.407604ms","start":"2026-04-20T05:52:20.629542Z","end":"2026-04-20T05:52:20.89395Z","steps":["trace[731406269] 'process raft request' (duration: 264.120387ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:31.341334Z","caller":"traceutil/trace.go:171","msg":"trace[2065729324] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"282.539733ms","start":"2026-04-20T05:52:31.058766Z","end":"2026-04-20T05:52:31.341306Z","steps":["trace[2065729324] 'process raft request' (duration: 282.372509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:31.640599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.405985ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:52:31.640722Z","caller":"traceutil/trace.go:171","msg":"trace[744319093] linearizableReadLoop","detail":"{readStateIndex:1423; appliedIndex:1422; }","duration":"138.206081ms","start":"2026-04-20T05:52:31.502496Z","end":"2026-04-20T05:52:31.640702Z","steps":["trace[744319093] 'read index received' (duration: 51.671µs)","trace[744319093] 'applied index is now lower than readState.Index' (duration: 138.15266ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:52:31.640762Z","caller":"traceutil/trace.go:171","msg":"trace[636091661] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"270.554437ms","start":"2026-04-20T05:52:31.370182Z","end":"2026-04-20T05:52:31.640736Z","steps":["trace[636091661] 'process raft request' (duration: 74.892734ms)","trace[636091661] 'compare' (duration: 195.222781ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:52:31.640883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.385766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-20T05:52:31.641037Z","caller":"traceutil/trace.go:171","msg":"trace[294799622] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1373; }","duration":"138.57772ms","start":"2026-04-20T05:52:31.502445Z","end":"2026-04-20T05:52:31.641023Z","steps":["trace[294799622] 'agreement among raft nodes before linearized reading' (duration: 138.314423ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:35.746122Z","caller":"traceutil/trace.go:171","msg":"trace[1911183367] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"115.343734ms","start":"2026-04-20T05:52:35.630747Z","end":"2026-04-20T05:52:35.746091Z","steps":["trace[1911183367] 'process raft request' (duration: 115.16828ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:36.729058Z","caller":"traceutil/trace.go:171","msg":"trace[1147861442] transaction","detail":"{read_only:false; response_revision:1395; number_of_response:1; }","duration":"369.613478ms","start":"2026-04-20T05:52:36.359428Z","end":"2026-04-20T05:52:36.729041Z","steps":["trace[1147861442] 'process raft request' (duration: 369.516636ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:36.729173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:36.359408Z","time spent":"369.69813ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:52:37.101709Z","caller":"traceutil/trace.go:171","msg":"trace[85264724] linearizableReadLoop","detail":"{readStateIndex:1447; appliedIndex:1445; }","duration":"552.971046ms","start":"2026-04-20T05:52:36.548702Z","end":"2026-04-20T05:52:37.101673Z","steps":["trace[85264724] 'read index received' (duration: 180.279332ms)","trace[85264724] 'applied index is now lower than readState.Index' (duration: 372.690284ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:52:37.101919Z","caller":"traceutil/trace.go:171","msg":"trace[450815852] transaction","detail":"{read_only:false; response_revision:1396; number_of_response:1; }","duration":"604.670356ms","start":"2026-04-20T05:52:36.497224Z","end":"2026-04-20T05:52:37.101895Z","steps":["trace[450815852] 'process raft request' (duration: 601.460057ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:37.102041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.311004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T05:52:37.102063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:36.497155Z","time spent":"604.792388ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:52:37.102075Z","caller":"traceutil/trace.go:171","msg":"trace[976623024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1396; }","duration":"553.406986ms","start":"2026-04-20T05:52:36.548658Z","end":"2026-04-20T05:52:37.102065Z","steps":["trace[976623024] 'agreement among raft nodes before linearized reading' (duration: 553.210172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:37.102097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:36.548642Z","time spent":"553.449527ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T05:52:37.102173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.755761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:52:37.10219Z","caller":"traceutil/trace.go:171","msg":"trace[532444711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1396; }","duration":"251.796462ms","start":"2026-04-20T05:52:36.850388Z","end":"2026-04-20T05:52:37.102184Z","steps":["trace[532444711] 'agreement among raft nodes before linearized reading' (duration: 251.764901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:37.102156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.2547ms","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-04-20T05:52:37.102275Z","caller":"traceutil/trace.go:171","msg":"trace[2082851997] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1396; }","duration":"546.378503ms","start":"2026-04-20T05:52:36.555846Z","end":"2026-04-20T05:52:37.102224Z","steps":["trace[2082851997] 'agreement among raft nodes before linearized reading' (duration: 546.152768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:37.102372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:36.555838Z","time spent":"546.521117ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-20T05:52:37.102302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.667123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-04-20T05:52:37.102456Z","caller":"traceutil/trace.go:171","msg":"trace[313586791] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1396; }","duration":"433.853468ms","start":"2026-04-20T05:52:36.668593Z","end":"2026-04-20T05:52:37.102447Z","steps":["trace[313586791] 'agreement among raft nodes before linearized reading' (duration: 433.560691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:37.102484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:52:36.668585Z","time spent":"433.889469ms","remote":"127.0.0.1:41114","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-20T05:54:31.510921Z","caller":"traceutil/trace.go:171","msg":"trace[1671202562] transaction","detail":"{read_only:false; response_revision:1921; number_of_response:1; }","duration":"237.919765ms","start":"2026-04-20T05:54:31.272973Z","end":"2026-04-20T05:54:31.510892Z","steps":["trace[1671202562] 'process raft request' (duration: 237.757192ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:35.623548Z","caller":"traceutil/trace.go:171","msg":"trace[760954963] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"223.002759ms","start":"2026-04-20T05:54:35.400331Z","end":"2026-04-20T05:54:35.623334Z","steps":["trace[760954963] 'process raft request' (duration: 222.618429ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:54:35.624099Z","caller":"traceutil/trace.go:171","msg":"trace[809697000] linearizableReadLoop","detail":"{readStateIndex:2015; appliedIndex:2013; }","duration":"100.295914ms","start":"2026-04-20T05:54:35.523774Z","end":"2026-04-20T05:54:35.624069Z","steps":["trace[809697000] 'read index received' (duration: 99.191957ms)","trace[809697000] 'applied index is now lower than readState.Index' (duration: 1.103007ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:54:35.624155Z","caller":"traceutil/trace.go:171","msg":"trace[140704277] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"101.834963ms","start":"2026-04-20T05:54:35.522294Z","end":"2026-04-20T05:54:35.624129Z","steps":["trace[140704277] 'process raft request' (duration: 101.652028ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:54:35.624309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.52006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-04-20T05:54:35.624347Z","caller":"traceutil/trace.go:171","msg":"trace[1340954067] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1940; }","duration":"100.593312ms","start":"2026-04-20T05:54:35.523741Z","end":"2026-04-20T05:54:35.624334Z","steps":["trace[1340954067] 'agreement among raft nodes before linearized reading' (duration: 100.436058ms)"],"step_count":1}