{"level":"warn","ts":"2026-04-25T15:59:02.308922Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-25T15:59:02.308996Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.250: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.250:2380","--initial-cluster=instance=https://199.204.45.250:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.250:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.250:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-25T15:59:02.30914Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-25T15:59:02.309156Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-25T15:59:02.309214Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-25T15:59:02.309881Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"]} {"level":"info","ts":"2026-04-25T15:59:02.310011Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.250:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-25T15:59:02.313565Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.327014ms"} {"level":"info","ts":"2026-04-25T15:59:02.319189Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d98d5f2c752cc52d","cluster-id":"c785b4aaf4bd3b11"} {"level":"info","ts":"2026-04-25T15:59:02.319284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=()"} {"level":"info","ts":"2026-04-25T15:59:02.319313Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 0"} {"level":"info","ts":"2026-04-25T15:59:02.319327Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d98d5f2c752cc52d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-25T15:59:02.319343Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became follower at term 1"} {"level":"info","ts":"2026-04-25T15:59:02.319388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"warn","ts":"2026-04-25T15:59:02.32768Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-25T15:59:02.329183Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-25T15:59:02.330363Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-25T15:59:02.332413Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d98d5f2c752cc52d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-25T15:59:02.332697Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d98d5f2c752cc52d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-25T15:59:02.332816Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-25T15:59:02.33292Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-25T15:59:02.332934Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-25T15:59:02.334936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d switched to configuration voters=(15676290522495632685)"} {"level":"info","ts":"2026-04-25T15:59:02.335337Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","added-peer-id":"d98d5f2c752cc52d","added-peer-peer-urls":["https://199.204.45.250:2380"]} {"level":"info","ts":"2026-04-25T15:59:02.336735Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-25T15:59:02.337278Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-25T15:59:02.337326Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d98d5f2c752cc52d","initial-advertise-peer-urls":["https://199.204.45.250:2380"],"listen-peer-urls":["https://199.204.45.250:2380"],"advertise-client-urls":["https://199.204.45.250:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.250:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-25T15:59:02.33739Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-25T15:59:02.337342Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.250:2380"} {"level":"info","ts":"2026-04-25T15:59:03.319653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d is starting a new election at term 1"} {"level":"info","ts":"2026-04-25T15:59:03.319705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-25T15:59:03.319722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgPreVoteResp from d98d5f2c752cc52d at term 1"} {"level":"info","ts":"2026-04-25T15:59:03.319736Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became candidate at term 2"} {"level":"info","ts":"2026-04-25T15:59:03.319744Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d received MsgVoteResp from d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-25T15:59:03.319755Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d98d5f2c752cc52d became leader at term 2"} {"level":"info","ts":"2026-04-25T15:59:03.319764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d98d5f2c752cc52d elected leader d98d5f2c752cc52d at term 2"} {"level":"info","ts":"2026-04-25T15:59:03.320722Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T15:59:03.321628Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-25T15:59:03.321628Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d98d5f2c752cc52d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.250:2379]}","request-path":"/0/members/d98d5f2c752cc52d/attributes","cluster-id":"c785b4aaf4bd3b11","publish-timeout":"7s"} {"level":"info","ts":"2026-04-25T15:59:03.321685Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-25T15:59:03.322007Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-25T15:59:03.322027Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-25T15:59:03.322383Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"c785b4aaf4bd3b11","local-member-id":"d98d5f2c752cc52d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T15:59:03.322457Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T15:59:03.322491Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-25T15:59:03.32486Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.250:2379"} {"level":"info","ts":"2026-04-25T15:59:03.32547Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-25T15:59:09.030857Z","caller":"traceutil/trace.go:171","msg":"trace[99699952] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"163.182848ms","start":"2026-04-25T15:59:08.867654Z","end":"2026-04-25T15:59:09.030837Z","steps":["trace[99699952] 'process raft request' (duration: 131.077276ms)","trace[99699952] 'compare' (duration: 31.960821ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T15:59:09.03095Z","caller":"traceutil/trace.go:171","msg":"trace[1585784357] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"162.173511ms","start":"2026-04-25T15:59:08.86874Z","end":"2026-04-25T15:59:09.030914Z","steps":["trace[1585784357] 'process raft request' (duration: 162.03231ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:09.031006Z","caller":"traceutil/trace.go:171","msg":"trace[407323252] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"161.793199ms","start":"2026-04-25T15:59:08.869158Z","end":"2026-04-25T15:59:09.030951Z","steps":["trace[407323252] 'process raft request' (duration: 161.640238ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:09.031044Z","caller":"traceutil/trace.go:171","msg":"trace[1694304548] transaction","detail":"{read_only:false; number_of_response:0; response_revision:260; }","duration":"161.581227ms","start":"2026-04-25T15:59:08.869436Z","end":"2026-04-25T15:59:09.031017Z","steps":["trace[1694304548] 'process raft request' (duration: 161.381646ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:09.031374Z","caller":"traceutil/trace.go:171","msg":"trace[450219782] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"125.266864ms","start":"2026-04-25T15:59:08.906096Z","end":"2026-04-25T15:59:09.031362Z","steps":["trace[450219782] 'process raft request' (duration: 124.738971ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:09.031304Z","caller":"traceutil/trace.go:171","msg":"trace[538761160] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:267; }","duration":"115.257562ms","start":"2026-04-25T15:59:08.916033Z","end":"2026-04-25T15:59:09.03129Z","steps":["trace[538761160] 'read index received' (duration: 82.714867ms)","trace[538761160] 'applied index is now lower than readState.Index' (duration: 32.541825ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T15:59:09.031648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.130496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-25T15:59:09.031721Z","caller":"traceutil/trace.go:171","msg":"trace[2107499202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:261; }","duration":"160.229347ms","start":"2026-04-25T15:59:08.871476Z","end":"2026-04-25T15:59:09.031706Z","steps":["trace[2107499202] 'agreement among raft nodes before linearized reading' (duration: 160.002325ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:09.345631Z","caller":"traceutil/trace.go:171","msg":"trace[1328150327] linearizableReadLoop","detail":"{readStateIndex:274; appliedIndex:272; }","duration":"314.153333ms","start":"2026-04-25T15:59:09.031452Z","end":"2026-04-25T15:59:09.345605Z","steps":["trace[1328150327] 'read index received' (duration: 313.898501ms)","trace[1328150327] 'applied index is now lower than readState.Index' (duration: 253.812µs)"],"step_count":2} {"level":"info","ts":"2026-04-25T15:59:09.345682Z","caller":"traceutil/trace.go:171","msg":"trace[1807677041] transaction","detail":"{read_only:false; response_revision:263; number_of_response:1; }","duration":"413.202697ms","start":"2026-04-25T15:59:08.932446Z","end":"2026-04-25T15:59:09.345648Z","steps":["trace[1807677041] 'process raft request' (duration: 413.092506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.345787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.71847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-25T15:59:09.34583Z","caller":"traceutil/trace.go:171","msg":"trace[1697466981] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:263; }","duration":"424.809161ms","start":"2026-04-25T15:59:08.92101Z","end":"2026-04-25T15:59:09.345819Z","steps":["trace[1697466981] 'agreement among raft nodes before linearized reading' (duration: 424.719721ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:09.345802Z","caller":"traceutil/trace.go:171","msg":"trace[1625403356] transaction","detail":"{read_only:false; response_revision:262; number_of_response:1; }","duration":"424.810401ms","start":"2026-04-25T15:59:08.920904Z","end":"2026-04-25T15:59:09.345715Z","steps":["trace[1625403356] 'process raft request' (duration: 424.460288ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.345869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:08.920999Z","time spent":"424.861922ms","remote":"127.0.0.1:38488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-25T15:59:09.346309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:08.92089Z","time spent":"424.986462ms","remote":"127.0.0.1:38314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":705,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-25T15:59:09.346315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:08.932437Z","time spent":"413.317768ms","remote":"127.0.0.1:38406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5149,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T15:59:09.807821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.292456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-25T15:59:09.807995Z","caller":"traceutil/trace.go:171","msg":"trace[1874416335] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"773.404581ms","start":"2026-04-25T15:59:09.034563Z","end":"2026-04-25T15:59:09.807967Z","steps":["trace[1874416335] 'process raft request' (duration: 516.742153ms)","trace[1874416335] 'compare' (duration: 256.200075ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T15:59:09.808046Z","caller":"traceutil/trace.go:171","msg":"trace[247324169] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"457.757957ms","start":"2026-04-25T15:59:09.350271Z","end":"2026-04-25T15:59:09.808029Z","steps":["trace[247324169] 'process raft request' (duration: 457.697436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.808126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.034552Z","time spent":"773.507542ms","remote":"127.0.0.1:38488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T15:59:09.808122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"775.753268ms","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-04-25T15:59:09.808175Z","caller":"traceutil/trace.go:171","msg":"trace[311909375] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:265; }","duration":"775.833679ms","start":"2026-04-25T15:59:09.032329Z","end":"2026-04-25T15:59:09.808162Z","steps":["trace[311909375] 'agreement among raft nodes before linearized reading' (duration: 775.727058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.808176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.841914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-25T15:59:09.808208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.032318Z","time spent":"775.883879ms","remote":"127.0.0.1:38406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2944,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"info","ts":"2026-04-25T15:59:09.808221Z","caller":"traceutil/trace.go:171","msg":"trace[936622715] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/statefulset-controller; range_end:; response_count:0; response_revision:265; }","duration":"773.900794ms","start":"2026-04-25T15:59:09.034305Z","end":"2026-04-25T15:59:09.808206Z","steps":["trace[936622715] 'agreement among raft nodes before linearized reading' (duration: 773.821083ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.80826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.034298Z","time spent":"773.955064ms","remote":"127.0.0.1:38434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/serviceaccounts/kube-system/statefulset-controller\" "} {"level":"warn","ts":"2026-04-25T15:59:09.808398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.428953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3468"} {"level":"info","ts":"2026-04-25T15:59:09.80843Z","caller":"traceutil/trace.go:171","msg":"trace[1178591085] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:265; }","duration":"776.479103ms","start":"2026-04-25T15:59:09.031943Z","end":"2026-04-25T15:59:09.808423Z","steps":["trace[1178591085] 'agreement among raft nodes before linearized reading' (duration: 776.411543ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.808461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.031932Z","time spent":"776.517864ms","remote":"127.0.0.1:38406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":3492,"request content":"key:\"/registry/pods/kube-system/kube-vip-instance\" "} {"level":"warn","ts":"2026-04-25T15:59:09.80853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.649994ms","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-04-25T15:59:09.808571Z","caller":"traceutil/trace.go:171","msg":"trace[967438318] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:265; }","duration":"776.724374ms","start":"2026-04-25T15:59:09.031839Z","end":"2026-04-25T15:59:09.808563Z","steps":["trace[967438318] 'agreement among raft nodes before linearized reading' (duration: 776.649684ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.808593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.031819Z","time spent":"776.769346ms","remote":"127.0.0.1:38406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5537,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"info","ts":"2026-04-25T15:59:09.808704Z","caller":"traceutil/trace.go:171","msg":"trace[367633006] linearizableReadLoop","detail":"{readStateIndex:275; appliedIndex:274; }","duration":"462.322841ms","start":"2026-04-25T15:59:09.345701Z","end":"2026-04-25T15:59:09.808024Z","steps":["trace[367633006] 'read index received' (duration: 205.704723ms)","trace[367633006] 'applied index is now lower than readState.Index' (duration: 256.614008ms)"],"step_count":2} {"level":"warn","ts":"2026-04-25T15:59:09.808817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.187578ms","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-04-25T15:59:09.808839Z","caller":"traceutil/trace.go:171","msg":"trace[980778623] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:265; }","duration":"459.246118ms","start":"2026-04-25T15:59:09.349587Z","end":"2026-04-25T15:59:09.808833Z","steps":["trace[980778623] 'agreement among raft nodes before linearized reading' (duration: 459.198568ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.808859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.349569Z","time spent":"459.285548ms","remote":"127.0.0.1:38406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":5537,"request content":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" "} {"level":"warn","ts":"2026-04-25T15:59:09.808862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.913594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-25T15:59:09.8089Z","caller":"traceutil/trace.go:171","msg":"trace[1736346776] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:265; }","duration":"126.973006ms","start":"2026-04-25T15:59:09.681917Z","end":"2026-04-25T15:59:09.80889Z","steps":["trace[1736346776] 'agreement among raft nodes before linearized reading' (duration: 126.884225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.809192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.35025Z","time spent":"457.832797ms","remote":"127.0.0.1:38488","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-25T15:59:09.809576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"777.540451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5164"} {"level":"info","ts":"2026-04-25T15:59:09.809676Z","caller":"traceutil/trace.go:171","msg":"trace[2032257007] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:265; }","duration":"777.678492ms","start":"2026-04-25T15:59:09.031973Z","end":"2026-04-25T15:59:09.809652Z","steps":["trace[2032257007] 'agreement among raft nodes before linearized reading' (duration: 776.13441ms)"],"step_count":1} {"level":"warn","ts":"2026-04-25T15:59:09.809787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-25T15:59:09.031962Z","time spent":"777.806084ms","remote":"127.0.0.1:38406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":5188,"request content":"key:\"/registry/pods/kube-system/etcd-instance\" "} {"level":"info","ts":"2026-04-25T15:59:10.019731Z","caller":"traceutil/trace.go:171","msg":"trace[1532984855] transaction","detail":"{read_only:false; response_revision:268; number_of_response:1; }","duration":"201.644643ms","start":"2026-04-25T15:59:09.818063Z","end":"2026-04-25T15:59:10.019707Z","steps":["trace[1532984855] 'process raft request' (duration: 201.602862ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:10.020119Z","caller":"traceutil/trace.go:171","msg":"trace[732715733] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"206.86814ms","start":"2026-04-25T15:59:09.813239Z","end":"2026-04-25T15:59:10.020107Z","steps":["trace[732715733] 'process raft request' (duration: 152.098046ms)","trace[732715733] 'compare' (duration: 54.13268ms)"],"step_count":2} {"level":"info","ts":"2026-04-25T15:59:10.020476Z","caller":"traceutil/trace.go:171","msg":"trace[357165075] transaction","detail":"{read_only:false; response_revision:267; number_of_response:1; }","duration":"206.461007ms","start":"2026-04-25T15:59:09.814005Z","end":"2026-04-25T15:59:10.020466Z","steps":["trace[357165075] 'process raft request' (duration: 205.603171ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:30.217292Z","caller":"traceutil/trace.go:171","msg":"trace[175234784] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"101.718154ms","start":"2026-04-25T15:59:30.115536Z","end":"2026-04-25T15:59:30.217254Z","steps":["trace[175234784] 'process raft request' (duration: 101.585023ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:34.469613Z","caller":"traceutil/trace.go:171","msg":"trace[1085645114] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"233.506888ms","start":"2026-04-25T15:59:34.236082Z","end":"2026-04-25T15:59:34.469589Z","steps":["trace[1085645114] 'process raft request' (duration: 233.365267ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:34.490564Z","caller":"traceutil/trace.go:171","msg":"trace[1870795836] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"113.802413ms","start":"2026-04-25T15:59:34.376736Z","end":"2026-04-25T15:59:34.490539Z","steps":["trace[1870795836] 'process raft request' (duration: 113.699222ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T15:59:35.017407Z","caller":"traceutil/trace.go:171","msg":"trace[1555140926] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"134.376785ms","start":"2026-04-25T15:59:34.88298Z","end":"2026-04-25T15:59:35.017357Z","steps":["trace[1555140926] 'process raft request' (duration: 129.585883ms)"],"step_count":1} {"level":"info","ts":"2026-04-25T16:00:36.663457Z","caller":"traceutil/trace.go:171","msg":"trace[169803936] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"131.149101ms","start":"2026-04-25T16:00:36.53228Z","end":"2026-04-25T16:00:36.663429Z","steps":["trace[169803936] 'process raft request' (duration: 130.98699ms)"],"step_count":1}