{"level":"warn","ts":"2026-02-02T17:46:48.517971Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-02T17:46:48.518136Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.181: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.181:2380","--initial-cluster=instance=https://199.19.213.181:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.181:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.181: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-02-02T17:46:48.520561Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-02T17:46:48.520645Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-02-02T17:46:48.520807Z","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-02-02T17:46:48.525794Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"]} {"level":"info","ts":"2026-02-02T17:46:48.525957Z","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":2,"max-cpu-available":2,"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.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.181: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-02-02T17:46:48.52944Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.192325ms"} {"level":"info","ts":"2026-02-02T17:46:48.535481Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1a532052a1358225","cluster-id":"b34324311008a1d3"} {"level":"info","ts":"2026-02-02T17:46:48.536651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=()"} {"level":"info","ts":"2026-02-02T17:46:48.536753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 0"} {"level":"info","ts":"2026-02-02T17:46:48.536843Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1a532052a1358225 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-02T17:46:48.536919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became follower at term 1"} {"level":"info","ts":"2026-02-02T17:46:48.537047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"warn","ts":"2026-02-02T17:46:48.544119Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-02T17:46:48.55108Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-02T17:46:48.555315Z","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-02-02T17:46:48.561281Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1a532052a1358225","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-02T17:46:48.562395Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1a532052a1358225","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-02T17:46:48.562989Z","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-02-02T17:46:48.563118Z","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-02-02T17:46:48.563182Z","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-02-02T17:46:48.564195Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 switched to configuration voters=(1896895407317156389)"} {"level":"info","ts":"2026-02-02T17:46:48.56433Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","added-peer-id":"1a532052a1358225","added-peer-peer-urls":["https://199.19.213.181:2380"]} {"level":"info","ts":"2026-02-02T17:46:48.565516Z","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-02-02T17:46:48.566212Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-02-02T17:46:48.56635Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.181:2380"} {"level":"info","ts":"2026-02-02T17:46:48.566917Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1a532052a1358225","initial-advertise-peer-urls":["https://199.19.213.181:2380"],"listen-peer-urls":["https://199.19.213.181:2380"],"advertise-client-urls":["https://199.19.213.181:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.181:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-02T17:46:48.568674Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-02T17:46:49.138992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 is starting a new election at term 1"} {"level":"info","ts":"2026-02-02T17:46:49.139129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-02T17:46:49.139244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgPreVoteResp from 1a532052a1358225 at term 1"} {"level":"info","ts":"2026-02-02T17:46:49.139303Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became candidate at term 2"} {"level":"info","ts":"2026-02-02T17:46:49.139345Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 received MsgVoteResp from 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-02-02T17:46:49.139409Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1a532052a1358225 became leader at term 2"} {"level":"info","ts":"2026-02-02T17:46:49.139469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1a532052a1358225 elected leader 1a532052a1358225 at term 2"} {"level":"info","ts":"2026-02-02T17:46:49.143316Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1a532052a1358225","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.181:2379]}","request-path":"/0/members/1a532052a1358225/attributes","cluster-id":"b34324311008a1d3","publish-timeout":"7s"} {"level":"info","ts":"2026-02-02T17:46:49.143394Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-02T17:46:49.143693Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T17:46:49.143901Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-02T17:46:49.144096Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-02T17:46:49.144154Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-02T17:46:49.145419Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.181:2379"} {"level":"info","ts":"2026-02-02T17:46:49.146092Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b34324311008a1d3","local-member-id":"1a532052a1358225","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T17:46:49.146222Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T17:46:49.146285Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-02T17:46:49.146872Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-02T17:47:17.359976Z","caller":"traceutil/trace.go:171","msg":"trace[997893487] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"121.364677ms","start":"2026-02-02T17:47:17.238588Z","end":"2026-02-02T17:47:17.359953Z","steps":["trace[997893487] 'process raft request' (duration: 121.243925ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:47:21.484744Z","caller":"traceutil/trace.go:171","msg":"trace[276128992] linearizableReadLoop","detail":"{readStateIndex:494; appliedIndex:493; }","duration":"111.456196ms","start":"2026-02-02T17:47:21.373271Z","end":"2026-02-02T17:47:21.484727Z","steps":["trace[276128992] 'read index received' (duration: 111.274533ms)","trace[276128992] 'applied index is now lower than readState.Index' (duration: 180.943µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T17:47:21.484827Z","caller":"traceutil/trace.go:171","msg":"trace[1746226758] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"111.70596ms","start":"2026-02-02T17:47:21.373116Z","end":"2026-02-02T17:47:21.484822Z","steps":["trace[1746226758] 'process raft request' (duration: 111.493797ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:21.484963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.677439ms","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-02-02T17:47:21.48498Z","caller":"traceutil/trace.go:171","msg":"trace[717002980] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:477; }","duration":"111.718221ms","start":"2026-02-02T17:47:21.373256Z","end":"2026-02-02T17:47:21.484975Z","steps":["trace[717002980] 'agreement among raft nodes before linearized reading' (duration: 111.67272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:21.485233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.411024ms","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-02-02T17:47:21.485303Z","caller":"traceutil/trace.go:171","msg":"trace[1085274208] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:477; }","duration":"104.499065ms","start":"2026-02-02T17:47:21.380786Z","end":"2026-02-02T17:47:21.485285Z","steps":["trace[1085274208] 'agreement among raft nodes before linearized reading' (duration: 104.279181ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:21.485329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.673934ms","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-02-02T17:47:21.485349Z","caller":"traceutil/trace.go:171","msg":"trace[955289483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:477; }","duration":"102.703134ms","start":"2026-02-02T17:47:21.38264Z","end":"2026-02-02T17:47:21.485343Z","steps":["trace[955289483] 'agreement among raft nodes before linearized reading' (duration: 102.619563ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:47:29.667053Z","caller":"traceutil/trace.go:171","msg":"trace[1727074215] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"137.900712ms","start":"2026-02-02T17:47:29.529113Z","end":"2026-02-02T17:47:29.667013Z","steps":["trace[1727074215] 'process raft request' (duration: 137.663058ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:47:29.901202Z","caller":"traceutil/trace.go:171","msg":"trace[348204018] linearizableReadLoop","detail":"{readStateIndex:519; appliedIndex:517; }","duration":"328.965746ms","start":"2026-02-02T17:47:29.572203Z","end":"2026-02-02T17:47:29.901168Z","steps":["trace[348204018] 'read index received' (duration: 94.62512ms)","trace[348204018] 'applied index is now lower than readState.Index' (duration: 234.339616ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T17:47:29.901584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.272905ms","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-02-02T17:47:29.901774Z","caller":"traceutil/trace.go:171","msg":"trace[1158521509] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:500; }","duration":"315.52491ms","start":"2026-02-02T17:47:29.586169Z","end":"2026-02-02T17:47:29.901694Z","steps":["trace[1158521509] 'agreement among raft nodes before linearized reading' (duration: 315.230185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:29.901826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:47:29.586114Z","time spent":"315.700944ms","remote":"127.0.0.1:53142","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":"info","ts":"2026-02-02T17:47:29.902914Z","caller":"traceutil/trace.go:171","msg":"trace[460659430] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"373.386031ms","start":"2026-02-02T17:47:29.52949Z","end":"2026-02-02T17:47:29.902876Z","steps":["trace[460659430] 'process raft request' (duration: 353.927251ms)","trace[460659430] 'compare' (duration: 17.465352ms)"],"step_count":2} {"level":"warn","ts":"2026-02-02T17:47:29.903116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.907413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-5ph2q\" ","response":"range_response_count:1 size:16656"} {"level":"info","ts":"2026-02-02T17:47:29.903156Z","caller":"traceutil/trace.go:171","msg":"trace[1307517704] range","detail":"{range_begin:/registry/pods/kube-system/cilium-5ph2q; range_end:; response_count:1; response_revision:500; }","duration":"330.970164ms","start":"2026-02-02T17:47:29.572174Z","end":"2026-02-02T17:47:29.903144Z","steps":["trace[1307517704] 'agreement among raft nodes before linearized reading' (duration: 330.813741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:29.903184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:47:29.572149Z","time spent":"331.029056ms","remote":"127.0.0.1:53046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16679,"request content":"key:\"/registry/pods/kube-system/cilium-5ph2q\" "} {"level":"warn","ts":"2026-02-02T17:47:29.903404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.598726ms","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-02-02T17:47:29.903432Z","caller":"traceutil/trace.go:171","msg":"trace[648663692] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:500; }","duration":"311.647706ms","start":"2026-02-02T17:47:29.591776Z","end":"2026-02-02T17:47:29.903424Z","steps":["trace[648663692] 'agreement among raft nodes before linearized reading' (duration: 311.575785ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:29.903458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:47:29.591765Z","time spent":"311.688037ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-02-02T17:47:29.903665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:47:29.529481Z","time spent":"373.488783ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-02T17:47:31.972092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.526482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T17:47:31.972175Z","caller":"traceutil/trace.go:171","msg":"trace[1121262649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:516; }","duration":"130.637504ms","start":"2026-02-02T17:47:31.841523Z","end":"2026-02-02T17:47:31.97216Z","steps":["trace[1121262649] 'range keys from in-memory index tree' (duration: 130.467461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:44.490178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.259221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-02T17:47:44.490253Z","caller":"traceutil/trace.go:171","msg":"trace[1402291364] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:648; }","duration":"136.379544ms","start":"2026-02-02T17:47:44.353849Z","end":"2026-02-02T17:47:44.490229Z","steps":["trace[1402291364] 'range keys from in-memory index tree' (duration: 136.082657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:47:45.047866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.633674ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-02T17:47:45.04799Z","caller":"traceutil/trace.go:171","msg":"trace[1292505584] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"187.066528ms","start":"2026-02-02T17:47:44.860907Z","end":"2026-02-02T17:47:45.047974Z","steps":["trace[1292505584] 'process raft request' (duration: 76.033046ms)","trace[1292505584] 'compare' (duration: 110.316568ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T17:47:45.110706Z","caller":"traceutil/trace.go:171","msg":"trace[2039939443] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"242.94556ms","start":"2026-02-02T17:47:44.867739Z","end":"2026-02-02T17:47:45.110684Z","steps":["trace[2039939443] 'process raft request' (duration: 242.887249ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:47:45.111071Z","caller":"traceutil/trace.go:171","msg":"trace[372911968] transaction","detail":"{read_only:false; response_revision:668; number_of_response:1; }","duration":"248.880802ms","start":"2026-02-02T17:47:44.862174Z","end":"2026-02-02T17:47:45.111055Z","steps":["trace[372911968] 'process raft request' (duration: 248.306152ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:47:45.111136Z","caller":"traceutil/trace.go:171","msg":"trace[1908507658] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"248.756271ms","start":"2026-02-02T17:47:44.862376Z","end":"2026-02-02T17:47:45.111132Z","steps":["trace[1908507658] 'process raft request' (duration: 248.224751ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:47:45.203965Z","caller":"traceutil/trace.go:171","msg":"trace[1976005699] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"141.93395ms","start":"2026-02-02T17:47:45.062001Z","end":"2026-02-02T17:47:45.203935Z","steps":["trace[1976005699] 'process raft request' (duration: 117.902663ms)","trace[1976005699] 'compare' (duration: 23.772142ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T17:48:12.182883Z","caller":"traceutil/trace.go:171","msg":"trace[1763169062] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"129.781588ms","start":"2026-02-02T17:48:12.053073Z","end":"2026-02-02T17:48:12.182855Z","steps":["trace[1763169062] 'process raft request' (duration: 128.536524ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:48:12.325528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.205725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-02T17:48:12.325731Z","caller":"traceutil/trace.go:171","msg":"trace[903721294] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:752; }","duration":"161.579033ms","start":"2026-02-02T17:48:12.164124Z","end":"2026-02-02T17:48:12.325703Z","steps":["trace[903721294] 'agreement among raft nodes before linearized reading' (duration: 19.261276ms)","trace[903721294] 'range keys from in-memory index tree' (duration: 141.96498ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T17:48:12.489657Z","caller":"traceutil/trace.go:171","msg":"trace[1009392128] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"137.010275ms","start":"2026-02-02T17:48:12.352625Z","end":"2026-02-02T17:48:12.489635Z","steps":["trace[1009392128] 'process raft request' (duration: 134.62978ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:48:24.380025Z","caller":"traceutil/trace.go:171","msg":"trace[42031556] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"121.315346ms","start":"2026-02-02T17:48:24.258677Z","end":"2026-02-02T17:48:24.379993Z","steps":["trace[42031556] 'process raft request' (duration: 120.530462ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:48:36.917416Z","caller":"traceutil/trace.go:171","msg":"trace[522492146] linearizableReadLoop","detail":"{readStateIndex:911; appliedIndex:910; }","duration":"200.91571ms","start":"2026-02-02T17:48:36.716488Z","end":"2026-02-02T17:48:36.917403Z","steps":["trace[522492146] 'read index received' (duration: 200.797937ms)","trace[522492146] 'applied index is now lower than readState.Index' (duration: 117.233µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T17:48:36.917587Z","caller":"traceutil/trace.go:171","msg":"trace[978431838] transaction","detail":"{read_only:false; response_revision:874; number_of_response:1; }","duration":"206.976701ms","start":"2026-02-02T17:48:36.710604Z","end":"2026-02-02T17:48:36.917581Z","steps":["trace[978431838] 'process raft request' (duration: 206.714476ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:48:36.917749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.249576ms","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-02-02T17:48:36.917768Z","caller":"traceutil/trace.go:171","msg":"trace[1032293009] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:874; }","duration":"201.289967ms","start":"2026-02-02T17:48:36.716471Z","end":"2026-02-02T17:48:36.917761Z","steps":["trace[1032293009] 'agreement among raft nodes before linearized reading' (duration: 201.224386ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:48:40.570928Z","caller":"traceutil/trace.go:171","msg":"trace[1598377207] transaction","detail":"{read_only:false; response_revision:882; number_of_response:1; }","duration":"124.068078ms","start":"2026-02-02T17:48:40.446839Z","end":"2026-02-02T17:48:40.570907Z","steps":["trace[1598377207] 'process raft request' (duration: 123.952056ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:51:47.641634Z","caller":"traceutil/trace.go:171","msg":"trace[1516015984] linearizableReadLoop","detail":"{readStateIndex:1752; appliedIndex:1751; }","duration":"177.863596ms","start":"2026-02-02T17:51:47.463729Z","end":"2026-02-02T17:51:47.641593Z","steps":["trace[1516015984] 'read index received' (duration: 177.490899ms)","trace[1516015984] 'applied index is now lower than readState.Index' (duration: 370.777µs)"],"step_count":2} {"level":"info","ts":"2026-02-02T17:51:47.641796Z","caller":"traceutil/trace.go:171","msg":"trace[35498652] transaction","detail":"{read_only:false; response_revision:1677; number_of_response:1; }","duration":"324.538101ms","start":"2026-02-02T17:51:47.317244Z","end":"2026-02-02T17:51:47.641782Z","steps":["trace[35498652] 'process raft request' (duration: 324.129233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:51:47.642608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.856584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"info","ts":"2026-02-02T17:51:47.642952Z","caller":"traceutil/trace.go:171","msg":"trace[1263592966] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1677; }","duration":"179.209021ms","start":"2026-02-02T17:51:47.463721Z","end":"2026-02-02T17:51:47.64293Z","steps":["trace[1263592966] 'agreement among raft nodes before linearized reading' (duration: 178.800503ms)"],"step_count":1} {"level":"warn","ts":"2026-02-02T17:51:47.712968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-02T17:51:47.317211Z","time spent":"324.622152ms","remote":"127.0.0.1:53142","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":518,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-02T17:51:48.610082Z","caller":"traceutil/trace.go:171","msg":"trace[812690748] transaction","detail":"{read_only:false; response_revision:1683; number_of_response:1; }","duration":"129.336161ms","start":"2026-02-02T17:51:48.480492Z","end":"2026-02-02T17:51:48.609829Z","steps":["trace[812690748] 'process raft request' (duration: 55.146588ms)","trace[812690748] 'compare' (duration: 74.062151ms)"],"step_count":2} {"level":"info","ts":"2026-02-02T17:51:49.756011Z","caller":"traceutil/trace.go:171","msg":"trace[1480276034] transaction","detail":"{read_only:false; response_revision:1686; number_of_response:1; }","duration":"173.049066ms","start":"2026-02-02T17:51:49.582934Z","end":"2026-02-02T17:51:49.755983Z","steps":["trace[1480276034] 'process raft request' (duration: 172.651369ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:51:49.888552Z","caller":"traceutil/trace.go:171","msg":"trace[1175735029] transaction","detail":"{read_only:false; response_revision:1688; number_of_response:1; }","duration":"125.537631ms","start":"2026-02-02T17:51:49.762985Z","end":"2026-02-02T17:51:49.888523Z","steps":["trace[1175735029] 'process raft request' (duration: 124.890129ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:51:49.89115Z","caller":"traceutil/trace.go:171","msg":"trace[1129690204] transaction","detail":"{read_only:false; response_revision:1689; number_of_response:1; }","duration":"125.992499ms","start":"2026-02-02T17:51:49.765148Z","end":"2026-02-02T17:51:49.89114Z","steps":["trace[1129690204] 'process raft request' (duration: 123.230908ms)"],"step_count":1} {"level":"info","ts":"2026-02-02T17:51:49.892127Z","caller":"traceutil/trace.go:171","msg":"trace[1003602736] transaction","detail":"{read_only:false; response_revision:1690; number_of_response:1; }","duration":"113.053928ms","start":"2026-02-02T17:51:49.778054Z","end":"2026-02-02T17:51:49.891108Z","steps":["trace[1003602736] 'process raft request' (duration: 112.836134ms)"],"step_count":1}