{"level":"warn","ts":"2026-03-25T16:58:29.113354Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-25T16:58:29.113482Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.126: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.19.213.126:2380","--initial-cluster=instance=https://199.19.213.126:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.126:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.126:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-03-25T16:58:29.113562Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-03-25T16:58:29.113571Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.126:2380"]} {"level":"info","ts":"2026-03-25T16:58:29.113602Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-25T16:58:29.114281Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"]} {"level":"info","ts":"2026-03-25T16:58:29.114369Z","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.19.213.126:2380"],"listen-peer-urls":["https://199.19.213.126:2380"],"advertise-client-urls":["https://199.19.213.126:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.126:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-03-25T16:58:29.11882Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.20867ms"} {"level":"info","ts":"2026-03-25T16:58:29.125652Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e241c9714ab70808","cluster-id":"e3245fbcce84a6b1"} {"level":"info","ts":"2026-03-25T16:58:29.125742Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=()"} {"level":"info","ts":"2026-03-25T16:58:29.125777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became follower at term 0"} {"level":"info","ts":"2026-03-25T16:58:29.125794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e241c9714ab70808 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-03-25T16:58:29.125809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became follower at term 1"} {"level":"info","ts":"2026-03-25T16:58:29.12586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=(16303533614479902728)"} {"level":"warn","ts":"2026-03-25T16:58:29.142294Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-03-25T16:58:29.14445Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-03-25T16:58:29.146246Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-03-25T16:58:29.149659Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e241c9714ab70808","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-03-25T16:58:29.149849Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e241c9714ab70808","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-03-25T16:58:29.150423Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-25T16:58:29.150532Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-25T16:58:29.151767Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-03-25T16:58:29.152658Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 switched to configuration voters=(16303533614479902728)"} {"level":"info","ts":"2026-03-25T16:58:29.152816Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e3245fbcce84a6b1","local-member-id":"e241c9714ab70808","added-peer-id":"e241c9714ab70808","added-peer-peer-urls":["https://199.19.213.126:2380"]} {"level":"info","ts":"2026-03-25T16:58:29.155564Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-03-25T16:58:29.155878Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e241c9714ab70808","initial-advertise-peer-urls":["https://199.19.213.126:2380"],"listen-peer-urls":["https://199.19.213.126:2380"],"advertise-client-urls":["https://199.19.213.126:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.126:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-03-25T16:58:29.155758Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.126:2380"} {"level":"info","ts":"2026-03-25T16:58:29.156516Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.126:2380"} {"level":"info","ts":"2026-03-25T16:58:29.155922Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-03-25T16:58:29.727031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 is starting a new election at term 1"} {"level":"info","ts":"2026-03-25T16:58:29.727127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became pre-candidate at term 1"} {"level":"info","ts":"2026-03-25T16:58:29.72724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 received MsgPreVoteResp from e241c9714ab70808 at term 1"} {"level":"info","ts":"2026-03-25T16:58:29.727267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became candidate at term 2"} {"level":"info","ts":"2026-03-25T16:58:29.727283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 received MsgVoteResp from e241c9714ab70808 at term 2"} {"level":"info","ts":"2026-03-25T16:58:29.7273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e241c9714ab70808 became leader at term 2"} {"level":"info","ts":"2026-03-25T16:58:29.727319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e241c9714ab70808 elected leader e241c9714ab70808 at term 2"} {"level":"info","ts":"2026-03-25T16:58:29.727997Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T16:58:29.728688Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e241c9714ab70808","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.126:2379]}","request-path":"/0/members/e241c9714ab70808/attributes","cluster-id":"e3245fbcce84a6b1","publish-timeout":"7s"} {"level":"info","ts":"2026-03-25T16:58:29.728713Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-25T16:58:29.72876Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-03-25T16:58:29.728939Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-03-25T16:58:29.72897Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-03-25T16:58:29.729107Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e3245fbcce84a6b1","local-member-id":"e241c9714ab70808","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T16:58:29.729234Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T16:58:29.729271Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-03-25T16:58:29.732676Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-03-25T16:58:29.733777Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.126:2379"} {"level":"info","ts":"2026-03-25T16:58:35.455538Z","caller":"traceutil/trace.go:171","msg":"trace[2095651132] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"140.094019ms","start":"2026-03-25T16:58:35.315421Z","end":"2026-03-25T16:58:35.455515Z","steps":["trace[2095651132] 'process raft request' (duration: 139.958266ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.455702Z","caller":"traceutil/trace.go:171","msg":"trace[944841939] linearizableReadLoop","detail":"{readStateIndex:274; appliedIndex:274; }","duration":"113.731414ms","start":"2026-03-25T16:58:35.341924Z","end":"2026-03-25T16:58:35.455656Z","steps":["trace[944841939] 'read index received' (duration: 113.717193ms)","trace[944841939] 'applied index is now lower than readState.Index' (duration: 12µs)"],"step_count":2} {"level":"warn","ts":"2026-03-25T16:58:35.455911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.948357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T16:58:35.455993Z","caller":"traceutil/trace.go:171","msg":"trace[1171812816] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:265; }","duration":"114.09286ms","start":"2026-03-25T16:58:35.341887Z","end":"2026-03-25T16:58:35.45598Z","steps":["trace[1171812816] 'agreement among raft nodes before linearized reading' (duration: 113.916336ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.621077Z","caller":"traceutil/trace.go:171","msg":"trace[1269758417] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"278.056737ms","start":"2026-03-25T16:58:35.342985Z","end":"2026-03-25T16:58:35.621042Z","steps":["trace[1269758417] 'process raft request' (duration: 277.765831ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.621133Z","caller":"traceutil/trace.go:171","msg":"trace[1359270483] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"267.791489ms","start":"2026-03-25T16:58:35.353326Z","end":"2026-03-25T16:58:35.621118Z","steps":["trace[1359270483] 'process raft request' (duration: 267.663967ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.621137Z","caller":"traceutil/trace.go:171","msg":"trace[1356010346] linearizableReadLoop","detail":"{readStateIndex:279; appliedIndex:274; }","duration":"165.279232ms","start":"2026-03-25T16:58:35.45582Z","end":"2026-03-25T16:58:35.6211Z","steps":["trace[1356010346] 'read index received' (duration: 164.966406ms)","trace[1356010346] 'applied index is now lower than readState.Index' (duration: 311.516µs)"],"step_count":2} {"level":"info","ts":"2026-03-25T16:58:35.621177Z","caller":"traceutil/trace.go:171","msg":"trace[924588157] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"267.474143ms","start":"2026-03-25T16:58:35.353643Z","end":"2026-03-25T16:58:35.621117Z","steps":["trace[924588157] 'process raft request' (duration: 267.379041ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.621187Z","caller":"traceutil/trace.go:171","msg":"trace[957800680] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"265.375103ms","start":"2026-03-25T16:58:35.355763Z","end":"2026-03-25T16:58:35.621138Z","steps":["trace[957800680] 'process raft request' (duration: 265.308742ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:58:35.621522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.498764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-03-25T16:58:35.621639Z","caller":"traceutil/trace.go:171","msg":"trace[1240343475] transaction","detail":"{read_only:false; number_of_response:0; response_revision:266; }","duration":"268.602465ms","start":"2026-03-25T16:58:35.353005Z","end":"2026-03-25T16:58:35.621607Z","steps":["trace[1240343475] 'process raft request' (duration: 267.931353ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.621638Z","caller":"traceutil/trace.go:171","msg":"trace[143566926] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:266; }","duration":"279.643096ms","start":"2026-03-25T16:58:35.341971Z","end":"2026-03-25T16:58:35.621614Z","steps":["trace[143566926] 'agreement among raft nodes before linearized reading' (duration: 279.28297ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.675874Z","caller":"traceutil/trace.go:171","msg":"trace[942820026] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"216.801222ms","start":"2026-03-25T16:58:35.459045Z","end":"2026-03-25T16:58:35.675846Z","steps":["trace[942820026] 'process raft request' (duration: 216.643589ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:58:35.675933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.060886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-03-25T16:58:35.676002Z","caller":"traceutil/trace.go:171","msg":"trace[429208341] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:267; }","duration":"217.183568ms","start":"2026-03-25T16:58:35.458802Z","end":"2026-03-25T16:58:35.675986Z","steps":["trace[429208341] 'agreement among raft nodes before linearized reading' (duration: 217.047556ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.796112Z","caller":"traceutil/trace.go:171","msg":"trace[164987565] linearizableReadLoop","detail":"{readStateIndex:281; appliedIndex:280; }","duration":"120.259358ms","start":"2026-03-25T16:58:35.67583Z","end":"2026-03-25T16:58:35.796089Z","steps":["trace[164987565] 'read index received' (duration: 120.184387ms)","trace[164987565] 'applied index is now lower than readState.Index' (duration: 73.811µs)"],"step_count":2} {"level":"warn","ts":"2026-03-25T16:58:35.796201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.616286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T16:58:35.796253Z","caller":"traceutil/trace.go:171","msg":"trace[494473353] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:268; }","duration":"169.702007ms","start":"2026-03-25T16:58:35.626537Z","end":"2026-03-25T16:58:35.796239Z","steps":["trace[494473353] 'agreement among raft nodes before linearized reading' (duration: 169.581255ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:58:35.79626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.533081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3980"} {"level":"info","ts":"2026-03-25T16:58:35.796287Z","caller":"traceutil/trace.go:171","msg":"trace[1705974300] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:268; }","duration":"173.573771ms","start":"2026-03-25T16:58:35.622704Z","end":"2026-03-25T16:58:35.796278Z","steps":["trace[1705974300] 'agreement among raft nodes before linearized reading' (duration: 173.53185ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:58:35.796518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.384046ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-03-25T16:58:35.796555Z","caller":"traceutil/trace.go:171","msg":"trace[785066548] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:268; }","duration":"174.463099ms","start":"2026-03-25T16:58:35.622084Z","end":"2026-03-25T16:58:35.796547Z","steps":["trace[785066548] 'agreement among raft nodes before linearized reading' (duration: 174.392988ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:58:35.79668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.57458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6755"} {"level":"info","ts":"2026-03-25T16:58:35.796711Z","caller":"traceutil/trace.go:171","msg":"trace[1705547863] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:268; }","duration":"174.619972ms","start":"2026-03-25T16:58:35.622084Z","end":"2026-03-25T16:58:35.796704Z","steps":["trace[1705547863] 'agreement among raft nodes before linearized reading' (duration: 174.573171ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:58:35.796215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.105022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-03-25T16:58:35.796797Z","caller":"traceutil/trace.go:171","msg":"trace[243073679] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:268; }","duration":"174.727324ms","start":"2026-03-25T16:58:35.622063Z","end":"2026-03-25T16:58:35.79679Z","steps":["trace[243073679] 'agreement among raft nodes before linearized reading' (duration: 174.112992ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.796864Z","caller":"traceutil/trace.go:171","msg":"trace[1104366723] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"158.108865ms","start":"2026-03-25T16:58:35.638747Z","end":"2026-03-25T16:58:35.796856Z","steps":["trace[1104366723] 'process raft request' (duration: 157.176997ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:35.807727Z","caller":"traceutil/trace.go:171","msg":"trace[656539013] transaction","detail":"{read_only:false; response_revision:269; number_of_response:1; }","duration":"127.996076ms","start":"2026-03-25T16:58:35.679718Z","end":"2026-03-25T16:58:35.807714Z","steps":["trace[656539013] 'process raft request' (duration: 127.756092ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.175455Z","caller":"traceutil/trace.go:171","msg":"trace[1463122240] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"164.835475ms","start":"2026-03-25T16:58:58.010595Z","end":"2026-03-25T16:58:58.175431Z","steps":["trace[1463122240] 'process raft request' (duration: 164.717783ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.182597Z","caller":"traceutil/trace.go:171","msg":"trace[1265501891] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"160.637914ms","start":"2026-03-25T16:58:58.021944Z","end":"2026-03-25T16:58:58.182582Z","steps":["trace[1265501891] 'process raft request' (duration: 160.42921ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.182781Z","caller":"traceutil/trace.go:171","msg":"trace[342163552] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"159.485473ms","start":"2026-03-25T16:58:58.023286Z","end":"2026-03-25T16:58:58.182771Z","steps":["trace[342163552] 'process raft request' (duration: 159.163637ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.18305Z","caller":"traceutil/trace.go:171","msg":"trace[146158936] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"157.86031ms","start":"2026-03-25T16:58:58.025159Z","end":"2026-03-25T16:58:58.183019Z","steps":["trace[146158936] 'process raft request' (duration: 157.392831ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.183456Z","caller":"traceutil/trace.go:171","msg":"trace[1223747146] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"153.819643ms","start":"2026-03-25T16:58:58.029625Z","end":"2026-03-25T16:58:58.183444Z","steps":["trace[1223747146] 'process raft request' (duration: 153.647049ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.183505Z","caller":"traceutil/trace.go:171","msg":"trace[1913032217] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"150.657061ms","start":"2026-03-25T16:58:58.032835Z","end":"2026-03-25T16:58:58.183492Z","steps":["trace[1913032217] 'process raft request' (duration: 150.504479ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.183793Z","caller":"traceutil/trace.go:171","msg":"trace[1902959299] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"150.896806ms","start":"2026-03-25T16:58:58.032883Z","end":"2026-03-25T16:58:58.18378Z","steps":["trace[1902959299] 'process raft request' (duration: 150.496468ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.186614Z","caller":"traceutil/trace.go:171","msg":"trace[148678119] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"138.139418ms","start":"2026-03-25T16:58:58.048442Z","end":"2026-03-25T16:58:58.186581Z","steps":["trace[148678119] 'process raft request' (duration: 137.781452ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.186842Z","caller":"traceutil/trace.go:171","msg":"trace[207133335] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"148.288075ms","start":"2026-03-25T16:58:58.038543Z","end":"2026-03-25T16:58:58.186831Z","steps":["trace[207133335] 'process raft request' (duration: 145.208145ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.186973Z","caller":"traceutil/trace.go:171","msg":"trace[239295968] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"136.634709ms","start":"2026-03-25T16:58:58.050327Z","end":"2026-03-25T16:58:58.186962Z","steps":["trace[239295968] 'process raft request' (duration: 135.941805ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:58.187086Z","caller":"traceutil/trace.go:171","msg":"trace[66903007] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"102.572809ms","start":"2026-03-25T16:58:58.084505Z","end":"2026-03-25T16:58:58.187078Z","steps":["trace[66903007] 'process raft request' (duration: 101.802513ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:58:59.795076Z","caller":"traceutil/trace.go:171","msg":"trace[1657498151] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"126.474432ms","start":"2026-03-25T16:58:59.668429Z","end":"2026-03-25T16:58:59.794903Z","steps":["trace[1657498151] 'process raft request' (duration: 111.862469ms)","trace[1657498151] 'compare' (duration: 14.495281ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T16:59:06.637364Z","caller":"traceutil/trace.go:171","msg":"trace[1814073396] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"186.256851ms","start":"2026-03-25T16:59:06.451087Z","end":"2026-03-25T16:59:06.637344Z","steps":["trace[1814073396] 'process raft request' (duration: 186.128649ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:59:06.999165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.952669ms","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-03-25T16:59:06.999325Z","caller":"traceutil/trace.go:171","msg":"trace[2132620470] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:641; }","duration":"147.170422ms","start":"2026-03-25T16:59:06.852119Z","end":"2026-03-25T16:59:06.999289Z","steps":["trace[2132620470] 'range keys from in-memory index tree' (duration: 146.717544ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:59:07.170444Z","caller":"traceutil/trace.go:171","msg":"trace[1960322332] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"167.426975ms","start":"2026-03-25T16:59:07.002988Z","end":"2026-03-25T16:59:07.170415Z","steps":["trace[1960322332] 'process raft request' (duration: 167.233831ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T16:59:07.172491Z","caller":"traceutil/trace.go:171","msg":"trace[1499826002] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"168.030637ms","start":"2026-03-25T16:59:07.00445Z","end":"2026-03-25T16:59:07.172481Z","steps":["trace[1499826002] 'process raft request' (duration: 167.974616ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T16:59:56.845219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.960996ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T16:59:56.845328Z","caller":"traceutil/trace.go:171","msg":"trace[813217515] transaction","detail":"{read_only:false; response_revision:968; number_of_response:1; }","duration":"120.022483ms","start":"2026-03-25T16:59:56.725292Z","end":"2026-03-25T16:59:56.845315Z","steps":["trace[813217515] 'process raft request' (duration: 15.505045ms)","trace[813217515] 'compare' (duration: 103.861254ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T17:00:21.123974Z","caller":"traceutil/trace.go:171","msg":"trace[736112969] transaction","detail":"{read_only:false; response_revision:1046; number_of_response:1; }","duration":"206.234469ms","start":"2026-03-25T17:00:20.917712Z","end":"2026-03-25T17:00:21.123947Z","steps":["trace[736112969] 'process raft request' (duration: 206.055766ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T17:00:50.564417Z","caller":"traceutil/trace.go:171","msg":"trace[692019904] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"122.366444ms","start":"2026-03-25T17:00:50.442028Z","end":"2026-03-25T17:00:50.564394Z","steps":["trace[692019904] 'process raft request' (duration: 122.227441ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T17:00:51.124767Z","caller":"traceutil/trace.go:171","msg":"trace[1865435816] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1273; }","duration":"110.867332ms","start":"2026-03-25T17:00:51.013859Z","end":"2026-03-25T17:00:51.124726Z","steps":["trace[1865435816] 'read index received' (duration: 99.067875ms)","trace[1865435816] 'applied index is now lower than readState.Index' (duration: 11.797387ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T17:00:51.124799Z","caller":"traceutil/trace.go:171","msg":"trace[1949671026] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"118.939959ms","start":"2026-03-25T17:00:51.005811Z","end":"2026-03-25T17:00:51.124751Z","steps":["trace[1949671026] 'process raft request' (duration: 107.177682ms)","trace[1949671026] 'compare' (duration: 11.541292ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T17:00:51.124987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.061307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-03-25T17:00:51.12516Z","caller":"traceutil/trace.go:171","msg":"trace[245661798] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:0; response_revision:1225; }","duration":"111.285441ms","start":"2026-03-25T17:00:51.013853Z","end":"2026-03-25T17:00:51.125138Z","steps":["trace[245661798] 'agreement among raft nodes before linearized reading' (duration: 110.981525ms)"],"step_count":1} {"level":"warn","ts":"2026-03-25T17:01:03.903724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.144686ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-03-25T17:01:03.903907Z","caller":"traceutil/trace.go:171","msg":"trace[423648157] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"333.469086ms","start":"2026-03-25T17:01:03.570375Z","end":"2026-03-25T17:01:03.903844Z","steps":["trace[423648157] 'process raft request' (duration: 12.107575ms)","trace[423648157] 'compare' (duration: 321.039274ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T17:01:03.904091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-03-25T17:01:03.57036Z","time spent":"333.638551ms","remote":"127.0.0.1:47452","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-03-25T17:01:04.09632Z","caller":"traceutil/trace.go:171","msg":"trace[1875073970] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"187.366965ms","start":"2026-03-25T17:01:03.908918Z","end":"2026-03-25T17:01:04.096285Z","steps":["trace[1875073970] 'process raft request' (duration: 95.486317ms)","trace[1875073970] 'compare' (duration: 91.51858ms)"],"step_count":2} {"level":"info","ts":"2026-03-25T17:01:04.096488Z","caller":"traceutil/trace.go:171","msg":"trace[2141592703] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"187.310623ms","start":"2026-03-25T17:01:03.909118Z","end":"2026-03-25T17:01:04.096429Z","steps":["trace[2141592703] 'process raft request' (duration: 187.058288ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T17:01:04.09657Z","caller":"traceutil/trace.go:171","msg":"trace[1472777468] linearizableReadLoop","detail":"{readStateIndex:1364; appliedIndex:1360; }","duration":"159.475845ms","start":"2026-03-25T17:01:03.937079Z","end":"2026-03-25T17:01:04.096555Z","steps":["trace[1472777468] 'read index received' (duration: 43.900879ms)","trace[1472777468] 'applied index is now lower than readState.Index' (duration: 115.574016ms)"],"step_count":2} {"level":"warn","ts":"2026-03-25T17:01:04.096781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.67312ms","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:526"} {"level":"info","ts":"2026-03-25T17:01:04.096836Z","caller":"traceutil/trace.go:171","msg":"trace[441996850] transaction","detail":"{read_only:false; response_revision:1312; number_of_response:1; }","duration":"187.699021ms","start":"2026-03-25T17:01:03.909117Z","end":"2026-03-25T17:01:04.096816Z","steps":["trace[441996850] 'process raft request' (duration: 187.388655ms)"],"step_count":1} {"level":"info","ts":"2026-03-25T17:01:04.098863Z","caller":"traceutil/trace.go:171","msg":"trace[766010690] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1312; }","duration":"161.05792ms","start":"2026-03-25T17:01:03.937011Z","end":"2026-03-25T17:01:04.098069Z","steps":["trace[766010690] 'agreement among raft nodes before linearized reading' (duration: 159.631669ms)"],"step_count":1}