{"level":"warn","ts":"2026-04-16T06:10:06.198388Z","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-16T06:10:06.198469Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.229: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.229:2380","--initial-cluster=instance=https://199.204.45.229:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.229:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.229: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-16T06:10:06.198561Z","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-16T06:10:06.198575Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-16T06:10:06.19859Z","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-16T06:10:06.199199Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"]} {"level":"info","ts":"2026-04-16T06:10:06.199269Z","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.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.229: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-16T06:10:06.203278Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.791143ms"} {"level":"info","ts":"2026-04-16T06:10:06.210288Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3ba9ae53cc4335db","cluster-id":"4ad2674607ff1d60"} {"level":"info","ts":"2026-04-16T06:10:06.210415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T06:10:06.210442Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 0"} {"level":"info","ts":"2026-04-16T06:10:06.210456Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3ba9ae53cc4335db [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T06:10:06.210476Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became follower at term 1"} {"level":"info","ts":"2026-04-16T06:10:06.210559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"warn","ts":"2026-04-16T06:10:06.217264Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T06:10:06.218567Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T06:10:06.219625Z","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-16T06:10:06.221616Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3ba9ae53cc4335db","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T06:10:06.221795Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3ba9ae53cc4335db","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T06:10:06.221914Z","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-16T06:10:06.221985Z","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-16T06:10:06.221994Z","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-16T06:10:06.22431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db switched to configuration voters=(4299158994234324443)"} {"level":"info","ts":"2026-04-16T06:10:06.224454Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","added-peer-id":"3ba9ae53cc4335db","added-peer-peer-urls":["https://199.204.45.229:2380"]} {"level":"info","ts":"2026-04-16T06:10:06.227524Z","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-16T06:10:06.227728Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-16T06:10:06.227756Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.229:2380"} {"level":"info","ts":"2026-04-16T06:10:06.228418Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3ba9ae53cc4335db","initial-advertise-peer-urls":["https://199.204.45.229:2380"],"listen-peer-urls":["https://199.204.45.229:2380"],"advertise-client-urls":["https://199.204.45.229:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.229:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T06:10:06.228454Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T06:10:07.111647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T06:10:07.111727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T06:10:07.111758Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgPreVoteResp from 3ba9ae53cc4335db at term 1"} {"level":"info","ts":"2026-04-16T06:10:07.111779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became candidate at term 2"} {"level":"info","ts":"2026-04-16T06:10:07.111791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db received MsgVoteResp from 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-16T06:10:07.111826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3ba9ae53cc4335db became leader at term 2"} {"level":"info","ts":"2026-04-16T06:10:07.111839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3ba9ae53cc4335db elected leader 3ba9ae53cc4335db at term 2"} {"level":"info","ts":"2026-04-16T06:10:07.112791Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:10:07.113752Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:10:07.113744Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3ba9ae53cc4335db","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.229:2379]}","request-path":"/0/members/3ba9ae53cc4335db/attributes","cluster-id":"4ad2674607ff1d60","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T06:10:07.113808Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T06:10:07.114329Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4ad2674607ff1d60","local-member-id":"3ba9ae53cc4335db","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:10:07.114452Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:10:07.1145Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T06:10:07.114762Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T06:10:07.114837Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T06:10:07.11703Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.229:2379"} {"level":"info","ts":"2026-04-16T06:10:07.11734Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-16T06:10:41.576625Z","caller":"traceutil/trace.go:171","msg":"trace[375043717] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"495.390916ms","start":"2026-04-16T06:10:41.081209Z","end":"2026-04-16T06:10:41.5766Z","steps":["trace[375043717] 'process raft request' (duration: 494.759069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:41.577054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.571791ms","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-16T06:10:41.577187Z","caller":"traceutil/trace.go:171","msg":"trace[483351804] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:614; }","duration":"171.755606ms","start":"2026-04-16T06:10:41.405405Z","end":"2026-04-16T06:10:41.57716Z","steps":["trace[483351804] 'agreement among raft nodes before linearized reading' (duration: 171.417316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:41.57729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:41.081186Z","time spent":"495.528629ms","remote":"127.0.0.1:35762","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:10:41.578269Z","caller":"traceutil/trace.go:171","msg":"trace[979874822] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"171.106107ms","start":"2026-04-16T06:10:41.405457Z","end":"2026-04-16T06:10:41.576563Z","steps":["trace[979874822] 'read index received' (duration: 170.242743ms)","trace[979874822] 'applied index is now lower than readState.Index' (duration: 862.494µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:42.051702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.035388ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T06:10:42.051892Z","caller":"traceutil/trace.go:171","msg":"trace[839743828] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"412.967104ms","start":"2026-04-16T06:10:41.638894Z","end":"2026-04-16T06:10:42.051861Z","steps":["trace[839743828] 'process raft request' (duration: 412.905902ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:10:42.051976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:41.63886Z","time spent":"413.073597ms","remote":"127.0.0.1:36228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T06:10:42.052Z","caller":"traceutil/trace.go:171","msg":"trace[235819936] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"470.813746ms","start":"2026-04-16T06:10:41.581149Z","end":"2026-04-16T06:10:42.051963Z","steps":["trace[235819936] 'process raft request' (duration: 58.210162ms)","trace[235819936] 'compare' (duration: 411.892264ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:10:42.052186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:10:41.581124Z","time spent":"470.965159ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:10:56.965898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.23233ms","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-16T06:10:56.965957Z","caller":"traceutil/trace.go:171","msg":"trace[1606243507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:776; }","duration":"154.336613ms","start":"2026-04-16T06:10:56.811607Z","end":"2026-04-16T06:10:56.965943Z","steps":["trace[1606243507] 'range keys from in-memory index tree' (duration: 154.078516ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:11:45.200417Z","caller":"traceutil/trace.go:171","msg":"trace[487483016] transaction","detail":"{read_only:false; response_revision:1033; number_of_response:1; }","duration":"129.676194ms","start":"2026-04-16T06:11:45.070723Z","end":"2026-04-16T06:11:45.200399Z","steps":["trace[487483016] 'process raft request' (duration: 129.563071ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:12.087715Z","caller":"traceutil/trace.go:171","msg":"trace[2077050461] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"128.760659ms","start":"2026-04-16T06:12:11.958929Z","end":"2026-04-16T06:12:12.08769Z","steps":["trace[2077050461] 'read index received' (duration: 128.587374ms)","trace[2077050461] 'applied index is now lower than readState.Index' (duration: 172.415µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:12:12.087866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.906314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:12:12.087911Z","caller":"traceutil/trace.go:171","msg":"trace[1455902407] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1183; }","duration":"129.008266ms","start":"2026-04-16T06:12:11.958885Z","end":"2026-04-16T06:12:12.087893Z","steps":["trace[1455902407] 'agreement among raft nodes before linearized reading' (duration: 128.901823ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:12.08827Z","caller":"traceutil/trace.go:171","msg":"trace[1585587513] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"212.971251ms","start":"2026-04-16T06:12:11.875285Z","end":"2026-04-16T06:12:12.088256Z","steps":["trace[1585587513] 'process raft request' (duration: 212.286993ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:29.743763Z","caller":"traceutil/trace.go:171","msg":"trace[1962015166] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"198.716981ms","start":"2026-04-16T06:12:29.545027Z","end":"2026-04-16T06:12:29.743744Z","steps":["trace[1962015166] 'process raft request' (duration: 198.618359ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:30.944531Z","caller":"traceutil/trace.go:171","msg":"trace[1598057919] linearizableReadLoop","detail":"{readStateIndex:1327; appliedIndex:1326; }","duration":"107.19566ms","start":"2026-04-16T06:12:30.837312Z","end":"2026-04-16T06:12:30.944508Z","steps":["trace[1598057919] 'read index received' (duration: 106.990504ms)","trace[1598057919] 'applied index is now lower than readState.Index' (duration: 204.326µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:30.944576Z","caller":"traceutil/trace.go:171","msg":"trace[1226833583] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"110.426879ms","start":"2026-04-16T06:12:30.834102Z","end":"2026-04-16T06:12:30.944529Z","steps":["trace[1226833583] 'process raft request' (duration: 110.269274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:30.944744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.407266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:12:30.944848Z","caller":"traceutil/trace.go:171","msg":"trace[472371868] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1276; }","duration":"107.510938ms","start":"2026-04-16T06:12:30.837302Z","end":"2026-04-16T06:12:30.944813Z","steps":["trace[472371868] 'agreement among raft nodes before linearized reading' (duration: 107.324483ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:31.117517Z","caller":"traceutil/trace.go:171","msg":"trace[1125998365] linearizableReadLoop","detail":"{readStateIndex:1334; appliedIndex:1331; }","duration":"133.675433ms","start":"2026-04-16T06:12:30.983827Z","end":"2026-04-16T06:12:31.117502Z","steps":["trace[1125998365] 'read index received' (duration: 123.036922ms)","trace[1125998365] 'applied index is now lower than readState.Index' (duration: 10.637871ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:12:31.117586Z","caller":"traceutil/trace.go:171","msg":"trace[654018369] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"136.673475ms","start":"2026-04-16T06:12:30.980907Z","end":"2026-04-16T06:12:31.117581Z","steps":["trace[654018369] 'process raft request' (duration: 125.86899ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:31.117678Z","caller":"traceutil/trace.go:171","msg":"trace[316268140] transaction","detail":"{read_only:false; response_revision:1283; number_of_response:1; }","duration":"133.879859ms","start":"2026-04-16T06:12:30.983776Z","end":"2026-04-16T06:12:31.117655Z","steps":["trace[316268140] 'process raft request' (duration: 133.697304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:31.117781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.94071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:621"} {"level":"info","ts":"2026-04-16T06:12:31.117803Z","caller":"traceutil/trace.go:171","msg":"trace[1443992404] range","detail":"{range_begin:/registry/configmaps/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1283; }","duration":"133.988422ms","start":"2026-04-16T06:12:30.983805Z","end":"2026-04-16T06:12:31.117794Z","steps":["trace[1443992404] 'agreement among raft nodes before linearized reading' (duration: 133.887199ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:31.118101Z","caller":"traceutil/trace.go:171","msg":"trace[1138786411] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"134.300571ms","start":"2026-04-16T06:12:30.983774Z","end":"2026-04-16T06:12:31.118074Z","steps":["trace[1138786411] 'process raft request' (duration: 133.672584ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.052777Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868766803496471,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-16T06:12:54.22045Z","caller":"traceutil/trace.go:171","msg":"trace[554905692] transaction","detail":"{read_only:false; response_revision:1409; number_of_response:1; }","duration":"878.319533ms","start":"2026-04-16T06:12:53.342112Z","end":"2026-04-16T06:12:54.220431Z","steps":["trace[554905692] 'process raft request' (duration: 878.20027ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.220576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:53.342097Z","time spent":"878.413107ms","remote":"127.0.0.1:35770","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":606,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:12:54.525903Z","caller":"traceutil/trace.go:171","msg":"trace[1122656904] linearizableReadLoop","detail":"{readStateIndex:1465; appliedIndex:1463; }","duration":"973.506719ms","start":"2026-04-16T06:12:53.55236Z","end":"2026-04-16T06:12:54.525867Z","steps":["trace[1122656904] 'read index received' (duration: 667.961511ms)","trace[1122656904] 'applied index is now lower than readState.Index' (duration: 305.543608ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:12:54.526484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"974.108735ms","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-16T06:12:54.526582Z","caller":"traceutil/trace.go:171","msg":"trace[63388170] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1410; }","duration":"974.254799ms","start":"2026-04-16T06:12:53.552308Z","end":"2026-04-16T06:12:54.526563Z","steps":["trace[63388170] 'agreement among raft nodes before linearized reading' (duration: 973.973361ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.526654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:53.552287Z","time spent":"974.357752ms","remote":"127.0.0.1:35946","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":"info","ts":"2026-04-16T06:12:54.526998Z","caller":"traceutil/trace.go:171","msg":"trace[348726139] transaction","detail":"{read_only:false; response_revision:1410; number_of_response:1; }","duration":"910.564977ms","start":"2026-04-16T06:12:53.616409Z","end":"2026-04-16T06:12:54.526974Z","steps":["trace[348726139] 'process raft request' (duration: 908.244404ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.527092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:53.616387Z","time spent":"910.648379ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:12:54.527119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.272332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T06:12:54.527255Z","caller":"traceutil/trace.go:171","msg":"trace[144446383] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1410; }","duration":"973.9556ms","start":"2026-04-16T06:12:53.553282Z","end":"2026-04-16T06:12:54.527237Z","steps":["trace[144446383] 'agreement among raft nodes before linearized reading' (duration: 973.182609ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.527304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:53.553257Z","time spent":"974.034913ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-16T06:12:54.527359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.023485ms","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:529"} {"level":"info","ts":"2026-04-16T06:12:54.527399Z","caller":"traceutil/trace.go:171","msg":"trace[1919985634] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1410; }","duration":"304.097797ms","start":"2026-04-16T06:12:54.223291Z","end":"2026-04-16T06:12:54.527389Z","steps":["trace[1919985634] 'agreement among raft nodes before linearized reading' (duration: 304.001555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.527431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.788956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T06:12:54.527434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.223266Z","time spent":"304.159159ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":551,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-04-16T06:12:54.527465Z","caller":"traceutil/trace.go:171","msg":"trace[1270893542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1410; }","duration":"565.850307ms","start":"2026-04-16T06:12:53.961606Z","end":"2026-04-16T06:12:54.527456Z","steps":["trace[1270893542] 'agreement among raft nodes before linearized reading' (duration: 565.795936ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.527471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.653169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-16T06:12:54.527491Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:53.961592Z","time spent":"565.893079ms","remote":"127.0.0.1:35680","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-04-16T06:12:54.527522Z","caller":"traceutil/trace.go:171","msg":"trace[962602416] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1410; }","duration":"253.73601ms","start":"2026-04-16T06:12:54.273779Z","end":"2026-04-16T06:12:54.527515Z","steps":["trace[962602416] 'agreement among raft nodes before linearized reading' (duration: 253.613777ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.527556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.996091ms","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-16T06:12:54.527586Z","caller":"traceutil/trace.go:171","msg":"trace[1611551550] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1410; }","duration":"676.063663ms","start":"2026-04-16T06:12:53.851515Z","end":"2026-04-16T06:12:54.527579Z","steps":["trace[1611551550] 'agreement among raft nodes before linearized reading' (duration: 675.987221ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:54.527611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:53.851498Z","time spent":"676.107653ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-16T06:12:55.236421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":3880868766803496476,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-16T06:12:55.692901Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.162528129s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-16T06:12:55.696607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.716593ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:12:55.696702Z","caller":"traceutil/trace.go:171","msg":"trace[2047243131] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1410; }","duration":"656.818706ms","start":"2026-04-16T06:12:55.039869Z","end":"2026-04-16T06:12:55.696687Z","steps":["trace[2047243131] 'range keys from in-memory index tree' (duration: 656.702833ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:55.696786Z","caller":"traceutil/trace.go:171","msg":"trace[2019837342] transaction","detail":"{read_only:false; response_revision:1411; number_of_response:1; }","duration":"1.166513198s","start":"2026-04-16T06:12:54.530241Z","end":"2026-04-16T06:12:55.696754Z","steps":["trace[2019837342] 'process raft request' (duration: 1.162799957s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:55.69694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.530212Z","time spent":"1.166644831s","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":514,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:12:55.698335Z","caller":"traceutil/trace.go:171","msg":"trace[675983248] transaction","detail":"{read_only:false; response_revision:1415; number_of_response:1; }","duration":"1.166518588s","start":"2026-04-16T06:12:54.531806Z","end":"2026-04-16T06:12:55.698325Z","steps":["trace[675983248] 'process raft request' (duration: 1.166476347s)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:55.698321Z","caller":"traceutil/trace.go:171","msg":"trace[2034868933] transaction","detail":"{read_only:false; response_revision:1412; number_of_response:1; }","duration":"1.167638118s","start":"2026-04-16T06:12:54.530658Z","end":"2026-04-16T06:12:55.698296Z","steps":["trace[2034868933] 'process raft request' (duration: 1.167492104s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:55.698409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.531792Z","time spent":"1.166573379s","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:12:55.698568Z","caller":"traceutil/trace.go:171","msg":"trace[2123865945] transaction","detail":"{read_only:false; response_revision:1413; number_of_response:1; }","duration":"1.167601527s","start":"2026-04-16T06:12:54.530958Z","end":"2026-04-16T06:12:55.69856Z","steps":["trace[2123865945] 'process raft request' (duration: 1.167266238s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:55.698646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.530942Z","time spent":"1.167650629s","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:12:55.69864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.530638Z","time spent":"1.167741321s","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:12:55.698681Z","caller":"traceutil/trace.go:171","msg":"trace[1477494980] transaction","detail":"{read_only:false; response_revision:1416; number_of_response:1; }","duration":"832.580384ms","start":"2026-04-16T06:12:54.86608Z","end":"2026-04-16T06:12:55.69866Z","steps":["trace[1477494980] 'process raft request' (duration: 832.223504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:55.698763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.866033Z","time spent":"832.691317ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:12:55.698721Z","caller":"traceutil/trace.go:171","msg":"trace[1937085892] transaction","detail":"{read_only:false; response_revision:1414; number_of_response:1; }","duration":"1.167658759s","start":"2026-04-16T06:12:54.531042Z","end":"2026-04-16T06:12:55.698701Z","steps":["trace[1937085892] 'process raft request' (duration: 1.167207657s)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:55.698959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.531035Z","time spent":"1.167863604s","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-16T06:12:55.705928Z","caller":"traceutil/trace.go:171","msg":"trace[573406422] linearizableReadLoop","detail":"{readStateIndex:1471; appliedIndex:1465; }","duration":"969.905189ms","start":"2026-04-16T06:12:54.736007Z","end":"2026-04-16T06:12:55.705912Z","steps":["trace[573406422] 'read index received' (duration: 957.254074ms)","trace[573406422] 'applied index is now lower than readState.Index' (duration: 12.650265ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:12:55.706112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.598495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-16T06:12:55.706142Z","caller":"traceutil/trace.go:171","msg":"trace[248821504] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1416; }","duration":"197.669087ms","start":"2026-04-16T06:12:55.508466Z","end":"2026-04-16T06:12:55.706135Z","steps":["trace[248821504] 'agreement among raft nodes before linearized reading' (duration: 197.592845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:55.706206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.508735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-16T06:12:55.706118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.116506ms","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-16T06:12:55.706254Z","caller":"traceutil/trace.go:171","msg":"trace[1550435743] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1416; }","duration":"181.593017ms","start":"2026-04-16T06:12:55.524647Z","end":"2026-04-16T06:12:55.70624Z","steps":["trace[1550435743] 'agreement among raft nodes before linearized reading' (duration: 181.518435ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:55.706292Z","caller":"traceutil/trace.go:171","msg":"trace[217674466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1416; }","duration":"970.358593ms","start":"2026-04-16T06:12:54.735927Z","end":"2026-04-16T06:12:55.706285Z","steps":["trace[217674466] 'agreement among raft nodes before linearized reading' (duration: 970.099535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:55.706324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:54.735909Z","time spent":"970.407173ms","remote":"127.0.0.1:35946","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":"info","ts":"2026-04-16T06:12:55.813478Z","caller":"traceutil/trace.go:171","msg":"trace[2102436664] transaction","detail":"{read_only:false; response_revision:1417; number_of_response:1; }","duration":"103.960043ms","start":"2026-04-16T06:12:55.709494Z","end":"2026-04-16T06:12:55.813454Z","steps":["trace[2102436664] 'process raft request' (duration: 103.802359ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:55.816247Z","caller":"traceutil/trace.go:171","msg":"trace[1001981904] transaction","detail":"{read_only:false; response_revision:1418; number_of_response:1; }","duration":"106.419721ms","start":"2026-04-16T06:12:55.709801Z","end":"2026-04-16T06:12:55.816221Z","steps":["trace[1001981904] 'process raft request' (duration: 106.233256ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:12:56.581198Z","caller":"traceutil/trace.go:171","msg":"trace[914465562] linearizableReadLoop","detail":"{readStateIndex:1475; appliedIndex:1474; }","duration":"405.08871ms","start":"2026-04-16T06:12:56.176055Z","end":"2026-04-16T06:12:56.581144Z","steps":["trace[914465562] 'read index received' (duration: 404.628828ms)","trace[914465562] 'applied index is now lower than readState.Index' (duration: 457.932µs)"],"step_count":2} {"level":"warn","ts":"2026-04-16T06:12:56.581546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.44921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-16T06:12:56.581666Z","caller":"traceutil/trace.go:171","msg":"trace[1325249330] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1419; }","duration":"405.621985ms","start":"2026-04-16T06:12:56.176013Z","end":"2026-04-16T06:12:56.581635Z","steps":["trace[1325249330] 'agreement among raft nodes before linearized reading' (duration: 405.240974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:56.581734Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:56.175995Z","time spent":"405.725817ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-16T06:12:56.582586Z","caller":"traceutil/trace.go:171","msg":"trace[542507171] transaction","detail":"{read_only:false; response_revision:1419; number_of_response:1; }","duration":"408.311958ms","start":"2026-04-16T06:12:56.172906Z","end":"2026-04-16T06:12:56.581218Z","steps":["trace[542507171] 'process raft request' (duration: 407.838595ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:56.582805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:56.172886Z","time spent":"409.798699ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-16T06:12:56.587018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.639361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:527"} {"level":"info","ts":"2026-04-16T06:12:56.587081Z","caller":"traceutil/trace.go:171","msg":"trace[2064608236] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1420; }","duration":"335.732813ms","start":"2026-04-16T06:12:56.251329Z","end":"2026-04-16T06:12:56.587061Z","steps":["trace[2064608236] 'agreement among raft nodes before linearized reading' (duration: 335.569479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:12:56.587119Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T06:12:56.25131Z","time spent":"335.800685ms","remote":"127.0.0.1:35946","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-04-16T06:15:05.106249Z","caller":"traceutil/trace.go:171","msg":"trace[2120481761] linearizableReadLoop","detail":"{readStateIndex:2151; appliedIndex:2150; }","duration":"145.117267ms","start":"2026-04-16T06:15:04.96111Z","end":"2026-04-16T06:15:05.106227Z","steps":["trace[2120481761] 'read index received' (duration: 145.022885ms)","trace[2120481761] 'applied index is now lower than readState.Index' (duration: 93.522µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T06:15:05.106356Z","caller":"traceutil/trace.go:171","msg":"trace[352345399] transaction","detail":"{read_only:false; response_revision:2070; number_of_response:1; }","duration":"260.438263ms","start":"2026-04-16T06:15:04.845908Z","end":"2026-04-16T06:15:05.106346Z","steps":["trace[352345399] 'process raft request' (duration: 260.192986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T06:15:05.106456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.337374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T06:15:05.106505Z","caller":"traceutil/trace.go:171","msg":"trace[845630322] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2070; }","duration":"145.432787ms","start":"2026-04-16T06:15:04.961063Z","end":"2026-04-16T06:15:05.106496Z","steps":["trace[845630322] 'agreement among raft nodes before linearized reading' (duration: 145.343664ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T06:15:05.108182Z","caller":"traceutil/trace.go:171","msg":"trace[1514561930] transaction","detail":"{read_only:false; response_revision:2071; number_of_response:1; }","duration":"118.502501ms","start":"2026-04-16T06:15:04.989668Z","end":"2026-04-16T06:15:05.10817Z","steps":["trace[1514561930] 'process raft request' (duration: 118.295096ms)"],"step_count":1}