{"level":"warn","ts":"2026-02-16T22:57:32.300411Z","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-16T22:57:32.300632Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.72:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.72:2380","--initial-cluster=instance=https://199.204.45.72:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.72:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.72:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-02-16T22:57:32.300837Z","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-16T22:57:32.300868Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-02-16T22:57:32.300916Z","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-16T22:57:32.301681Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"]} {"level":"info","ts":"2026-02-16T22:57:32.30182Z","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.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.72:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-02-16T22:57:32.364171Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"56.889125ms"} {"level":"info","ts":"2026-02-16T22:57:32.472255Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"50e03cebfd94cbba","cluster-id":"120c03c1d5b80f94"} {"level":"info","ts":"2026-02-16T22:57:32.472383Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=()"} {"level":"info","ts":"2026-02-16T22:57:32.472436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 0"} {"level":"info","ts":"2026-02-16T22:57:32.472464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 50e03cebfd94cbba [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-16T22:57:32.472481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became follower at term 1"} {"level":"info","ts":"2026-02-16T22:57:32.472549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"warn","ts":"2026-02-16T22:57:32.57858Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-16T22:57:32.583388Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-16T22:57:32.587215Z","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-16T22:57:32.591293Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"50e03cebfd94cbba","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-16T22:57:32.594281Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"50e03cebfd94cbba","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-16T22:57:32.594474Z","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-16T22:57:32.594549Z","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-16T22:57:32.594583Z","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-16T22:57:32.594864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba switched to configuration voters=(5827724902086790074)"} {"level":"info","ts":"2026-02-16T22:57:32.595011Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","added-peer-id":"50e03cebfd94cbba","added-peer-peer-urls":["https://199.204.45.72:2380"]} {"level":"info","ts":"2026-02-16T22:57:32.610003Z","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-16T22:57:32.610163Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"50e03cebfd94cbba","initial-advertise-peer-urls":["https://199.204.45.72:2380"],"listen-peer-urls":["https://199.204.45.72:2380"],"advertise-client-urls":["https://199.204.45.72:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.72:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-16T22:57:32.6102Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-16T22:57:32.610271Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-02-16T22:57:32.610279Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.72:2380"} {"level":"info","ts":"2026-02-16T22:57:33.373325Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba is starting a new election at term 1"} {"level":"info","ts":"2026-02-16T22:57:33.373378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became pre-candidate at term 1"} {"level":"info","ts":"2026-02-16T22:57:33.373394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgPreVoteResp from 50e03cebfd94cbba at term 1"} {"level":"info","ts":"2026-02-16T22:57:33.373408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became candidate at term 2"} {"level":"info","ts":"2026-02-16T22:57:33.373413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba received MsgVoteResp from 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-02-16T22:57:33.373421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"50e03cebfd94cbba became leader at term 2"} {"level":"info","ts":"2026-02-16T22:57:33.373428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 50e03cebfd94cbba elected leader 50e03cebfd94cbba at term 2"} {"level":"info","ts":"2026-02-16T22:57:33.374489Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"50e03cebfd94cbba","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.72:2379]}","request-path":"/0/members/50e03cebfd94cbba/attributes","cluster-id":"120c03c1d5b80f94","publish-timeout":"7s"} {"level":"info","ts":"2026-02-16T22:57:33.374643Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-16T22:57:33.37507Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:57:33.375216Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-16T22:57:33.378071Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.72:2379"} {"level":"info","ts":"2026-02-16T22:57:33.378981Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"120c03c1d5b80f94","local-member-id":"50e03cebfd94cbba","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:57:33.379081Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:57:33.379103Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-16T22:57:33.381443Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-16T22:57:33.381459Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-16T22:57:33.383992Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-16T22:57:49.677626Z","caller":"traceutil/trace.go:171","msg":"trace[1001326560] linearizableReadLoop","detail":"{readStateIndex:389; appliedIndex:387; }","duration":"645.285493ms","start":"2026-02-16T22:57:49.032324Z","end":"2026-02-16T22:57:49.67761Z","steps":["trace[1001326560] 'read index received' (duration: 68.144776ms)","trace[1001326560] 'applied index is now lower than readState.Index' (duration: 577.139767ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:57:49.677772Z","caller":"traceutil/trace.go:171","msg":"trace[375316068] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"652.234899ms","start":"2026-02-16T22:57:49.02553Z","end":"2026-02-16T22:57:49.677765Z","steps":["trace[375316068] 'process raft request' (duration: 591.52816ms)","trace[375316068] 'compare' (duration: 60.451577ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:57:49.678074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:57:49.025515Z","time spent":"652.273961ms","remote":"127.0.0.1:43984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-16T22:57:49.67822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"645.89902ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-16T22:57:49.678242Z","caller":"traceutil/trace.go:171","msg":"trace[1869725739] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:374; }","duration":"645.938111ms","start":"2026-02-16T22:57:49.032298Z","end":"2026-02-16T22:57:49.678237Z","steps":["trace[1869725739] 'agreement among raft nodes before linearized reading' (duration: 645.89708ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:57:49.67826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:57:49.032278Z","time spent":"645.976873ms","remote":"127.0.0.1:43796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-16T22:57:49.678342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"642.335103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-16T22:57:49.678355Z","caller":"traceutil/trace.go:171","msg":"trace[1174723443] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:374; }","duration":"642.377664ms","start":"2026-02-16T22:57:49.035974Z","end":"2026-02-16T22:57:49.678351Z","steps":["trace[1174723443] 'agreement among raft nodes before linearized reading' (duration: 642.353003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:57:49.678367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:57:49.035964Z","time spent":"642.400136ms","remote":"127.0.0.1:43796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-16T22:57:49.678514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.387751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:6894"} {"level":"info","ts":"2026-02-16T22:57:49.67853Z","caller":"traceutil/trace.go:171","msg":"trace[353260717] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:374; }","duration":"346.470244ms","start":"2026-02-16T22:57:49.332056Z","end":"2026-02-16T22:57:49.678526Z","steps":["trace[353260717] 'agreement among raft nodes before linearized reading' (duration: 346.428112ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:57:49.678543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:57:49.332037Z","time spent":"346.502946ms","remote":"127.0.0.1:43710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":6916,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-02-16T22:57:49.67863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"461.005241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-16T22:57:49.678644Z","caller":"traceutil/trace.go:171","msg":"trace[1472955035] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:374; }","duration":"461.055262ms","start":"2026-02-16T22:57:49.217584Z","end":"2026-02-16T22:57:49.678639Z","steps":["trace[1472955035] 'agreement among raft nodes before linearized reading' (duration: 461.032201ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:57:49.678655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:57:49.217563Z","time spent":"461.089434ms","remote":"127.0.0.1:43796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-16T22:57:49.913562Z","caller":"traceutil/trace.go:171","msg":"trace[1372593074] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"221.448317ms","start":"2026-02-16T22:57:49.692091Z","end":"2026-02-16T22:57:49.91354Z","steps":["trace[1372593074] 'process raft request' (duration: 216.353773ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:57:49.915498Z","caller":"traceutil/trace.go:171","msg":"trace[177949066] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"221.799582ms","start":"2026-02-16T22:57:49.693686Z","end":"2026-02-16T22:57:49.915485Z","steps":["trace[177949066] 'process raft request' (duration: 221.76158ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:57:49.915791Z","caller":"traceutil/trace.go:171","msg":"trace[315775381] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"223.315839ms","start":"2026-02-16T22:57:49.692447Z","end":"2026-02-16T22:57:49.915763Z","steps":["trace[315775381] 'process raft request' (duration: 222.894631ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:57:49.915823Z","caller":"traceutil/trace.go:171","msg":"trace[1748469584] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"223.425374ms","start":"2026-02-16T22:57:49.692391Z","end":"2026-02-16T22:57:49.915816Z","steps":["trace[1748469584] 'process raft request' (duration: 220.785497ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:57:49.916218Z","caller":"traceutil/trace.go:171","msg":"trace[715054880] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"223.683365ms","start":"2026-02-16T22:57:49.692525Z","end":"2026-02-16T22:57:49.916208Z","steps":["trace[715054880] 'process raft request' (duration: 222.89101ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:57:56.668382Z","caller":"traceutil/trace.go:171","msg":"trace[122224552] transaction","detail":"{read_only:false; response_revision:423; number_of_response:1; }","duration":"294.676634ms","start":"2026-02-16T22:57:56.373676Z","end":"2026-02-16T22:57:56.668353Z","steps":["trace[122224552] 'process raft request' (duration: 294.331089ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:01.015462Z","caller":"traceutil/trace.go:171","msg":"trace[1339675745] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"102.32665ms","start":"2026-02-16T22:58:00.913112Z","end":"2026-02-16T22:58:01.015438Z","steps":["trace[1339675745] 'process raft request' (duration: 101.992745ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:10.466186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.47332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-16T22:58:10.466272Z","caller":"traceutil/trace.go:171","msg":"trace[1709553014] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:515; }","duration":"207.596147ms","start":"2026-02-16T22:58:10.258657Z","end":"2026-02-16T22:58:10.466253Z","steps":["trace[1709553014] 'range keys from in-memory index tree' (duration: 207.369056ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:10.705933Z","caller":"traceutil/trace.go:171","msg":"trace[174965107] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:534; }","duration":"235.087666ms","start":"2026-02-16T22:58:10.470831Z","end":"2026-02-16T22:58:10.705919Z","steps":["trace[174965107] 'read index received' (duration: 235.014273ms)","trace[174965107] 'applied index is now lower than readState.Index' (duration: 72.803µs)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:10.706031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.188241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6534"} {"level":"info","ts":"2026-02-16T22:58:10.70605Z","caller":"traceutil/trace.go:171","msg":"trace[1394269842] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:516; }","duration":"235.248574ms","start":"2026-02-16T22:58:10.470796Z","end":"2026-02-16T22:58:10.706045Z","steps":["trace[1394269842] 'agreement among raft nodes before linearized reading' (duration: 235.178091ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:10.706008Z","caller":"traceutil/trace.go:171","msg":"trace[2111947709] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"394.371289ms","start":"2026-02-16T22:58:10.31161Z","end":"2026-02-16T22:58:10.705981Z","steps":["trace[2111947709] 'process raft request' (duration: 394.208122ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:10.706218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:10.311548Z","time spent":"394.554088ms","remote":"127.0.0.1:43600","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":688,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-16T22:58:11.613203Z","caller":"traceutil/trace.go:171","msg":"trace[230720047] linearizableReadLoop","detail":"{readStateIndex:536; appliedIndex:535; }","duration":"142.723195ms","start":"2026-02-16T22:58:11.470465Z","end":"2026-02-16T22:58:11.613188Z","steps":["trace[230720047] 'read index received' (duration: 142.590649ms)","trace[230720047] 'applied index is now lower than readState.Index' (duration: 131.986µs)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:11.613346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.862201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-55ztr\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-16T22:58:11.613368Z","caller":"traceutil/trace.go:171","msg":"trace[2138241264] range","detail":"{range_begin:/registry/pods/kube-system/cilium-55ztr; range_end:; response_count:1; response_revision:517; }","duration":"142.901463ms","start":"2026-02-16T22:58:11.470461Z","end":"2026-02-16T22:58:11.613362Z","steps":["trace[2138241264] 'agreement among raft nodes before linearized reading' (duration: 142.786347ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:11.613585Z","caller":"traceutil/trace.go:171","msg":"trace[714527010] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"273.184609ms","start":"2026-02-16T22:58:11.340389Z","end":"2026-02-16T22:58:11.613574Z","steps":["trace[714527010] 'process raft request' (duration: 272.716478ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:12.345407Z","caller":"traceutil/trace.go:171","msg":"trace[1565787824] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"712.850018ms","start":"2026-02-16T22:58:11.63254Z","end":"2026-02-16T22:58:12.34539Z","steps":["trace[1565787824] 'process raft request' (duration: 700.324216ms)","trace[1565787824] 'compare' (duration: 11.905714ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:12.345501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:11.63252Z","time spent":"712.931502ms","remote":"127.0.0.1:43710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-16T22:58:12.355585Z","caller":"traceutil/trace.go:171","msg":"trace[1195624995] linearizableReadLoop","detail":"{readStateIndex:538; appliedIndex:536; }","duration":"314.908958ms","start":"2026-02-16T22:58:12.040663Z","end":"2026-02-16T22:58:12.355572Z","steps":["trace[1195624995] 'read index received' (duration: 292.2107ms)","trace[1195624995] 'applied index is now lower than readState.Index' (duration: 22.697398ms)"],"step_count":2} {"level":"warn","ts":"2026-02-16T22:58:12.355712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.035743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-16T22:58:12.355729Z","caller":"traceutil/trace.go:171","msg":"trace[835816722] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:518; }","duration":"315.091897ms","start":"2026-02-16T22:58:12.040632Z","end":"2026-02-16T22:58:12.355724Z","steps":["trace[835816722] 'agreement among raft nodes before linearized reading' (duration: 315.002613ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:12.355752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-16T22:58:12.040618Z","time spent":"315.129538ms","remote":"127.0.0.1:43796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":526,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-16T22:58:12.355783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.491294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-16T22:58:12.355858Z","caller":"traceutil/trace.go:171","msg":"trace[1644134217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:518; }","duration":"284.605179ms","start":"2026-02-16T22:58:12.07124Z","end":"2026-02-16T22:58:12.355845Z","steps":["trace[1644134217] 'agreement among raft nodes before linearized reading' (duration: 284.433971ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:12.356322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.464848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-16T22:58:12.356366Z","caller":"traceutil/trace.go:171","msg":"trace[302157611] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:518; }","duration":"252.514071ms","start":"2026-02-16T22:58:12.103834Z","end":"2026-02-16T22:58:12.356348Z","steps":["trace[302157611] 'agreement among raft nodes before linearized reading' (duration: 252.192196ms)"],"step_count":1} {"level":"warn","ts":"2026-02-16T22:58:12.356942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.055634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-02-16T22:58:12.356972Z","caller":"traceutil/trace.go:171","msg":"trace[941933402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:518; }","duration":"280.092806ms","start":"2026-02-16T22:58:12.076866Z","end":"2026-02-16T22:58:12.356959Z","steps":["trace[941933402] 'agreement among raft nodes before linearized reading' (duration: 279.174866ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:18.41721Z","caller":"traceutil/trace.go:171","msg":"trace[1931551741] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"104.185739ms","start":"2026-02-16T22:58:18.313008Z","end":"2026-02-16T22:58:18.417194Z","steps":["trace[1931551741] 'process raft request' (duration: 102.772294ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:39.437788Z","caller":"traceutil/trace.go:171","msg":"trace[1308257933] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"113.934003ms","start":"2026-02-16T22:58:39.323813Z","end":"2026-02-16T22:58:39.437747Z","steps":["trace[1308257933] 'process raft request' (duration: 113.779532ms)"],"step_count":1} {"level":"info","ts":"2026-02-16T22:58:52.816205Z","caller":"traceutil/trace.go:171","msg":"trace[2070786553] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"106.756169ms","start":"2026-02-16T22:58:52.709429Z","end":"2026-02-16T22:58:52.816185Z","steps":["trace[2070786553] 'process raft request' (duration: 34.808366ms)","trace[2070786553] 'compare' (duration: 71.450656ms)"],"step_count":2} {"level":"info","ts":"2026-02-16T22:59:32.434425Z","caller":"traceutil/trace.go:171","msg":"trace[1537281985] transaction","detail":"{read_only:false; response_revision:930; number_of_response:1; }","duration":"134.188339ms","start":"2026-02-16T22:59:32.30022Z","end":"2026-02-16T22:59:32.434409Z","steps":["trace[1537281985] 'process raft request' (duration: 134.062636ms)"],"step_count":1}