{"level":"warn","ts":"2026-04-16T13:08:21.918176Z","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-16T13:08:21.918314Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.201: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.201:2380","--initial-cluster=instance=https://199.19.213.201:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.201:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.201: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-16T13:08:21.918428Z","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-16T13:08:21.918455Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.201:2380"]} {"level":"info","ts":"2026-04-16T13:08:21.91849Z","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-16T13:08:21.919845Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.201:2379"]} {"level":"info","ts":"2026-04-16T13:08:21.920626Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.201:2380"],"listen-peer-urls":["https://199.19.213.201:2380"],"advertise-client-urls":["https://199.19.213.201:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.201:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.201: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-16T13:08:21.926997Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.084536ms"} {"level":"info","ts":"2026-04-16T13:08:21.935227Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"61bc451777564e43","cluster-id":"b1814cb801e33ddc"} {"level":"info","ts":"2026-04-16T13:08:21.935332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 switched to configuration voters=()"} {"level":"info","ts":"2026-04-16T13:08:21.935364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 became follower at term 0"} {"level":"info","ts":"2026-04-16T13:08:21.935381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 61bc451777564e43 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-16T13:08:21.935394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 became follower at term 1"} {"level":"info","ts":"2026-04-16T13:08:21.935436Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 switched to configuration voters=(7042579884389322307)"} {"level":"warn","ts":"2026-04-16T13:08:21.941354Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-16T13:08:21.945898Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-16T13:08:21.947384Z","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-16T13:08:21.949766Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"61bc451777564e43","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-16T13:08:21.950057Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"61bc451777564e43","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-16T13:08:21.950203Z","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-16T13:08:21.950393Z","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-16T13:08:21.950408Z","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-16T13:08:21.950967Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 switched to configuration voters=(7042579884389322307)"} {"level":"info","ts":"2026-04-16T13:08:21.951108Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b1814cb801e33ddc","local-member-id":"61bc451777564e43","added-peer-id":"61bc451777564e43","added-peer-peer-urls":["https://199.19.213.201:2380"]} {"level":"info","ts":"2026-04-16T13:08:21.953821Z","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-16T13:08:21.954097Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"61bc451777564e43","initial-advertise-peer-urls":["https://199.19.213.201:2380"],"listen-peer-urls":["https://199.19.213.201:2380"],"advertise-client-urls":["https://199.19.213.201:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.201:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-16T13:08:21.954135Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-16T13:08:21.954412Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.201:2380"} {"level":"info","ts":"2026-04-16T13:08:21.95448Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.201:2380"} {"level":"info","ts":"2026-04-16T13:08:22.236115Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 is starting a new election at term 1"} {"level":"info","ts":"2026-04-16T13:08:22.23618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-16T13:08:22.236215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 received MsgPreVoteResp from 61bc451777564e43 at term 1"} {"level":"info","ts":"2026-04-16T13:08:22.236245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 became candidate at term 2"} {"level":"info","ts":"2026-04-16T13:08:22.236256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 received MsgVoteResp from 61bc451777564e43 at term 2"} {"level":"info","ts":"2026-04-16T13:08:22.236266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"61bc451777564e43 became leader at term 2"} {"level":"info","ts":"2026-04-16T13:08:22.236279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 61bc451777564e43 elected leader 61bc451777564e43 at term 2"} {"level":"info","ts":"2026-04-16T13:08:22.237078Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"61bc451777564e43","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.201:2379]}","request-path":"/0/members/61bc451777564e43/attributes","cluster-id":"b1814cb801e33ddc","publish-timeout":"7s"} {"level":"info","ts":"2026-04-16T13:08:22.237241Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T13:08:22.237115Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T13:08:22.237321Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-16T13:08:22.237965Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b1814cb801e33ddc","local-member-id":"61bc451777564e43","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T13:08:22.238104Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T13:08:22.238142Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-16T13:08:22.238438Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-16T13:08:22.238464Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-16T13:08:22.240244Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.201:2379"} {"level":"info","ts":"2026-04-16T13:08:22.24178Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-16T13:08:27.997321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.610709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T13:08:27.997558Z","caller":"traceutil/trace.go:171","msg":"trace[906884818] linearizableReadLoop","detail":"{readStateIndex:293; appliedIndex:291; }","duration":"380.475556ms","start":"2026-04-16T13:08:27.61706Z","end":"2026-04-16T13:08:27.997536Z","steps":["trace[906884818] 'read index received' (duration: 38.999366ms)","trace[906884818] 'applied index is now lower than readState.Index' (duration: 341.47522ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T13:08:27.997671Z","caller":"traceutil/trace.go:171","msg":"trace[1974064766] transaction","detail":"{read_only:false; response_revision:286; number_of_response:1; }","duration":"383.073423ms","start":"2026-04-16T13:08:27.614583Z","end":"2026-04-16T13:08:27.997656Z","steps":["trace[1974064766] 'process raft request' (duration: 41.46357ms)","trace[1974064766] 'compare' (duration: 340.398266ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T13:08:27.997759Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.61456Z","time spent":"383.149744ms","remote":"127.0.0.1:54676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":625,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T13:08:27.997913Z","caller":"traceutil/trace.go:171","msg":"trace[2063612933] transaction","detail":"{read_only:false; response_revision:287; number_of_response:1; }","duration":"382.112249ms","start":"2026-04-16T13:08:27.615767Z","end":"2026-04-16T13:08:27.99788Z","steps":["trace[2063612933] 'process raft request' (duration: 381.699203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:27.99795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.811492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-16T13:08:27.998003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.615745Z","time spent":"382.217501ms","remote":"127.0.0.1:54854","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T13:08:27.998066Z","caller":"traceutil/trace.go:171","msg":"trace[236244448] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:0; response_revision:287; }","duration":"381.012604ms","start":"2026-04-16T13:08:27.617026Z","end":"2026-04-16T13:08:27.998038Z","steps":["trace[236244448] 'agreement among raft nodes before linearized reading' (duration: 380.72715ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:27.998125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.617013Z","time spent":"381.099545ms","remote":"127.0.0.1:54790","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-04-16T13:08:28.071459Z","caller":"traceutil/trace.go:171","msg":"trace[658249770] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"356.661931ms","start":"2026-04-16T13:08:27.71477Z","end":"2026-04-16T13:08:28.071432Z","steps":["trace[658249770] 'process raft request' (duration: 356.512759ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:28.071589Z","caller":"traceutil/trace.go:171","msg":"trace[1435890961] transaction","detail":"{read_only:false; response_revision:291; number_of_response:1; }","duration":"355.593077ms","start":"2026-04-16T13:08:27.71597Z","end":"2026-04-16T13:08:28.071563Z","steps":["trace[1435890961] 'process raft request' (duration: 355.528666ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:28.0716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.714755Z","time spent":"356.782254ms","remote":"127.0.0.1:54774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T13:08:28.071711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.715957Z","time spent":"355.697388ms","remote":"127.0.0.1:54774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3453,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T13:08:28.071788Z","caller":"traceutil/trace.go:171","msg":"trace[1460132140] transaction","detail":"{read_only:false; response_revision:289; number_of_response:1; }","duration":"356.774113ms","start":"2026-04-16T13:08:27.714999Z","end":"2026-04-16T13:08:28.071774Z","steps":["trace[1460132140] 'process raft request' (duration: 356.346987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:28.071877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.714991Z","time spent":"356.845774ms","remote":"127.0.0.1:54774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T13:08:28.071765Z","caller":"traceutil/trace.go:171","msg":"trace[310213570] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"355.764309ms","start":"2026-04-16T13:08:27.715791Z","end":"2026-04-16T13:08:28.071555Z","steps":["trace[310213570] 'process raft request' (duration: 355.677048ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:28.072048Z","caller":"traceutil/trace.go:171","msg":"trace[1814752995] transaction","detail":"{read_only:false; number_of_response:0; response_revision:289; }","duration":"356.302397ms","start":"2026-04-16T13:08:27.715736Z","end":"2026-04-16T13:08:28.072038Z","steps":["trace[1814752995] 'process raft request' (duration: 355.704498ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:28.072109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.715725Z","time spent":"356.359517ms","remote":"127.0.0.1:54774","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-16T13:08:28.071392Z","caller":"traceutil/trace.go:171","msg":"trace[1041390454] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"377.188769ms","start":"2026-04-16T13:08:27.694178Z","end":"2026-04-16T13:08:28.071367Z","steps":["trace[1041390454] 'process raft request' (duration: 377.030847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:28.072287Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.715759Z","time spent":"356.188605ms","remote":"127.0.0.1:54774","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T13:08:28.072364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.694153Z","time spent":"378.171353ms","remote":"127.0.0.1:54762","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T13:08:28.072894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.923367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:115"} {"level":"info","ts":"2026-04-16T13:08:28.072973Z","caller":"traceutil/trace.go:171","msg":"trace[62604277] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:291; }","duration":"430.88256ms","start":"2026-04-16T13:08:27.642068Z","end":"2026-04-16T13:08:28.072951Z","steps":["trace[62604277] 'agreement among raft nodes before linearized reading' (duration: 429.737944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:28.073035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:27.642044Z","time spent":"430.966482ms","remote":"127.0.0.1:54664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":138,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"info","ts":"2026-04-16T13:08:28.325227Z","caller":"traceutil/trace.go:171","msg":"trace[2072534364] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"230.544521ms","start":"2026-04-16T13:08:28.094666Z","end":"2026-04-16T13:08:28.325211Z","steps":["trace[2072534364] 'process raft request' (duration: 230.491761ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:28.325236Z","caller":"traceutil/trace.go:171","msg":"trace[1392115766] transaction","detail":"{read_only:false; response_revision:293; number_of_response:1; }","duration":"250.458779ms","start":"2026-04-16T13:08:28.074747Z","end":"2026-04-16T13:08:28.325205Z","steps":["trace[1392115766] 'process raft request' (duration: 247.543459ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:28.325293Z","caller":"traceutil/trace.go:171","msg":"trace[1209196530] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"230.615042ms","start":"2026-04-16T13:08:28.094659Z","end":"2026-04-16T13:08:28.325274Z","steps":["trace[1209196530] 'process raft request' (duration: 230.424419ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:28.325607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.963067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5897"} {"level":"info","ts":"2026-04-16T13:08:28.325685Z","caller":"traceutil/trace.go:171","msg":"trace[221857919] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:295; }","duration":"251.118119ms","start":"2026-04-16T13:08:28.074548Z","end":"2026-04-16T13:08:28.325666Z","steps":["trace[221857919] 'agreement among raft nodes before linearized reading' (duration: 250.874435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:28.325915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.120979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-04-16T13:08:28.325981Z","caller":"traceutil/trace.go:171","msg":"trace[886558216] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:295; }","duration":"251.328932ms","start":"2026-04-16T13:08:28.074635Z","end":"2026-04-16T13:08:28.325964Z","steps":["trace[886558216] 'agreement among raft nodes before linearized reading' (duration: 251.026878ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:28.325191Z","caller":"traceutil/trace.go:171","msg":"trace[1585376232] linearizableReadLoop","detail":"{readStateIndex:301; appliedIndex:300; }","duration":"233.800057ms","start":"2026-04-16T13:08:28.091363Z","end":"2026-04-16T13:08:28.325163Z","steps":["trace[1585376232] 'read index received' (duration: 230.944377ms)","trace[1585376232] 'applied index is now lower than readState.Index' (duration: 2.85307ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T13:08:48.987325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.115167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-16T13:08:48.987403Z","caller":"traceutil/trace.go:171","msg":"trace[1345896858] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:506; }","duration":"177.240168ms","start":"2026-04-16T13:08:48.810145Z","end":"2026-04-16T13:08:48.987385Z","steps":["trace[1345896858] 'range keys from in-memory index tree' (duration: 176.979745ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:48.987558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.398661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-16T13:08:48.987634Z","caller":"traceutil/trace.go:171","msg":"trace[613026193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:506; }","duration":"177.511372ms","start":"2026-04-16T13:08:48.810104Z","end":"2026-04-16T13:08:48.987615Z","steps":["trace[613026193] 'range keys from in-memory index tree' (duration: 177.207487ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:48.988156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.023924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T13:08:48.988277Z","caller":"traceutil/trace.go:171","msg":"trace[1084825241] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:506; }","duration":"107.109639ms","start":"2026-04-16T13:08:48.881137Z","end":"2026-04-16T13:08:48.988246Z","steps":["trace[1084825241] 'range keys from in-memory index tree' (duration: 105.917773ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:55.159172Z","caller":"traceutil/trace.go:171","msg":"trace[2053156367] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"112.278515ms","start":"2026-04-16T13:08:55.046874Z","end":"2026-04-16T13:08:55.159153Z","steps":["trace[2053156367] 'process raft request' (duration: 112.166104ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:55.210955Z","caller":"traceutil/trace.go:171","msg":"trace[1663547231] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"161.459394ms","start":"2026-04-16T13:08:55.049473Z","end":"2026-04-16T13:08:55.210932Z","steps":["trace[1663547231] 'process raft request' (duration: 161.316502ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:08:55.421937Z","caller":"traceutil/trace.go:171","msg":"trace[1053948570] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"198.926456ms","start":"2026-04-16T13:08:55.222985Z","end":"2026-04-16T13:08:55.421912Z","steps":["trace[1053948570] 'process raft request' (duration: 193.294521ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:55.970801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.36355ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-16T13:08:55.970935Z","caller":"traceutil/trace.go:171","msg":"trace[1346233799] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"332.999714ms","start":"2026-04-16T13:08:55.637883Z","end":"2026-04-16T13:08:55.970883Z","steps":["trace[1346233799] 'read index received' (duration: 122.443282ms)","trace[1346233799] 'applied index is now lower than readState.Index' (duration: 210.555222ms)"],"step_count":2} {"level":"info","ts":"2026-04-16T13:08:55.970947Z","caller":"traceutil/trace.go:171","msg":"trace[673950934] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"495.180638ms","start":"2026-04-16T13:08:55.475709Z","end":"2026-04-16T13:08:55.970889Z","steps":["trace[673950934] 'process raft request' (duration: 284.662356ms)","trace[673950934] 'compare' (duration: 210.240548ms)"],"step_count":2} {"level":"warn","ts":"2026-04-16T13:08:55.971053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.168096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-16T13:08:55.971084Z","caller":"traceutil/trace.go:171","msg":"trace[400297453] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"333.204087ms","start":"2026-04-16T13:08:55.637871Z","end":"2026-04-16T13:08:55.971075Z","steps":["trace[400297453] 'agreement among raft nodes before linearized reading' (duration: 333.127256ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:55.971072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:55.47568Z","time spent":"495.34434ms","remote":"127.0.0.1:55090","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-16T13:08:55.971109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-16T13:08:55.637817Z","time spent":"333.285628ms","remote":"127.0.0.1:54600","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-16T13:08:55.971161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.47047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.201\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-16T13:08:55.971236Z","caller":"traceutil/trace.go:171","msg":"trace[1293584396] range","detail":"{range_begin:/registry/masterleases/199.19.213.201; range_end:; response_count:1; response_revision:615; }","duration":"227.57807ms","start":"2026-04-16T13:08:55.743635Z","end":"2026-04-16T13:08:55.971213Z","steps":["trace[1293584396] 'agreement among raft nodes before linearized reading' (duration: 227.462699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:08:55.971182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.495172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-64pjz\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-16T13:08:55.971437Z","caller":"traceutil/trace.go:171","msg":"trace[133031511] range","detail":"{range_begin:/registry/pods/kube-system/cilium-64pjz; range_end:; response_count:1; response_revision:615; }","duration":"254.742315ms","start":"2026-04-16T13:08:55.716645Z","end":"2026-04-16T13:08:55.971387Z","steps":["trace[133031511] 'agreement among raft nodes before linearized reading' (duration: 254.41577ms)"],"step_count":1} {"level":"info","ts":"2026-04-16T13:09:10.977962Z","caller":"traceutil/trace.go:171","msg":"trace[172173644] linearizableReadLoop","detail":"{readStateIndex:802; appliedIndex:801; }","duration":"112.257899ms","start":"2026-04-16T13:09:10.86568Z","end":"2026-04-16T13:09:10.977938Z","steps":["trace[172173644] 'read index received' (duration: 112.081667ms)","trace[172173644] 'applied index is now lower than readState.Index' (duration: 175.162µs)"],"step_count":2} {"level":"info","ts":"2026-04-16T13:09:10.978001Z","caller":"traceutil/trace.go:171","msg":"trace[1888457843] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"160.745359ms","start":"2026-04-16T13:09:10.817217Z","end":"2026-04-16T13:09:10.977963Z","steps":["trace[1888457843] 'process raft request' (duration: 160.549576ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:09:10.978178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.476672ms","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-16T13:09:10.978259Z","caller":"traceutil/trace.go:171","msg":"trace[1396253986] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:777; }","duration":"112.576514ms","start":"2026-04-16T13:09:10.865631Z","end":"2026-04-16T13:09:10.978208Z","steps":["trace[1396253986] 'agreement among raft nodes before linearized reading' (duration: 112.412672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-16T13:09:11.222027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.902531ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-16T13:09:11.222336Z","caller":"traceutil/trace.go:171","msg":"trace[204289986] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"238.712692ms","start":"2026-04-16T13:09:10.98359Z","end":"2026-04-16T13:09:11.222303Z","steps":["trace[204289986] 'process raft request' (duration: 35.278194ms)","trace[204289986] 'compare' (duration: 202.581057ms)"],"step_count":2}