{"level":"warn","ts":"2026-05-27T13:51:31.582915Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T13:51:31.58304Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.205: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.205:2380","--initial-cluster=instance=https://199.204.45.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.205: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-05-27T13:51:31.583278Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-27T13:51:31.583308Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-05-27T13:51:31.583382Z","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-05-27T13:51:31.58428Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"]} {"level":"info","ts":"2026-05-27T13:51:31.584465Z","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.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.205: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-05-27T13:51:31.588206Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.208941ms"} {"level":"info","ts":"2026-05-27T13:51:31.599118Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"71d28e9ac1bc4e5d","cluster-id":"4a4ae660c7a9a6a7"} {"level":"info","ts":"2026-05-27T13:51:31.599232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=()"} {"level":"info","ts":"2026-05-27T13:51:31.599262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 0"} {"level":"info","ts":"2026-05-27T13:51:31.599299Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 71d28e9ac1bc4e5d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-27T13:51:31.599309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became follower at term 1"} {"level":"info","ts":"2026-05-27T13:51:31.599386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"warn","ts":"2026-05-27T13:51:31.603659Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-27T13:51:31.605014Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-27T13:51:31.606049Z","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-05-27T13:51:31.608195Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"71d28e9ac1bc4e5d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-27T13:51:31.608326Z","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-05-27T13:51:31.608417Z","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-05-27T13:51:31.608435Z","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-05-27T13:51:31.608389Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"71d28e9ac1bc4e5d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-27T13:51:31.609252Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d switched to configuration voters=(8201774666721545821)"} {"level":"info","ts":"2026-05-27T13:51:31.609921Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","added-peer-id":"71d28e9ac1bc4e5d","added-peer-peer-urls":["https://199.204.45.205:2380"]} {"level":"info","ts":"2026-05-27T13:51:31.613652Z","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-05-27T13:51:31.613846Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-05-27T13:51:31.613938Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.205:2380"} {"level":"info","ts":"2026-05-27T13:51:31.614074Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"71d28e9ac1bc4e5d","initial-advertise-peer-urls":["https://199.204.45.205:2380"],"listen-peer-urls":["https://199.204.45.205:2380"],"advertise-client-urls":["https://199.204.45.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-27T13:51:31.614174Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-27T13:51:32.099655Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d is starting a new election at term 1"} {"level":"info","ts":"2026-05-27T13:51:32.099743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became pre-candidate at term 1"} {"level":"info","ts":"2026-05-27T13:51:32.099781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgPreVoteResp from 71d28e9ac1bc4e5d at term 1"} {"level":"info","ts":"2026-05-27T13:51:32.099802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became candidate at term 2"} {"level":"info","ts":"2026-05-27T13:51:32.099813Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d received MsgVoteResp from 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-05-27T13:51:32.099829Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"71d28e9ac1bc4e5d became leader at term 2"} {"level":"info","ts":"2026-05-27T13:51:32.099842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 71d28e9ac1bc4e5d elected leader 71d28e9ac1bc4e5d at term 2"} {"level":"info","ts":"2026-05-27T13:51:32.100523Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:51:32.101287Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"71d28e9ac1bc4e5d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.205:2379]}","request-path":"/0/members/71d28e9ac1bc4e5d/attributes","cluster-id":"4a4ae660c7a9a6a7","publish-timeout":"7s"} {"level":"info","ts":"2026-05-27T13:51:32.101427Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:51:32.101537Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-27T13:51:32.102128Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4a4ae660c7a9a6a7","local-member-id":"71d28e9ac1bc4e5d","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:51:32.102266Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:51:32.102309Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-27T13:51:32.104604Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.205:2379"} {"level":"info","ts":"2026-05-27T13:51:32.105489Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-27T13:51:32.105547Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-27T13:51:32.107726Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-27T13:51:37.844029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.496085ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:51:37.844215Z","caller":"traceutil/trace.go:171","msg":"trace[896183227] transaction","detail":"{read_only:false; response_revision:255; number_of_response:1; }","duration":"201.981708ms","start":"2026-05-27T13:51:37.642203Z","end":"2026-05-27T13:51:37.844185Z","steps":["trace[896183227] 'process raft request' (duration: 55.2708ms)","trace[896183227] 'compare' (duration: 144.849803ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:37.844331Z","caller":"traceutil/trace.go:171","msg":"trace[1966190646] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"199.368989ms","start":"2026-05-27T13:51:37.644942Z","end":"2026-05-27T13:51:37.844311Z","steps":["trace[1966190646] 'process raft request' (duration: 199.252116ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:37.844812Z","caller":"traceutil/trace.go:171","msg":"trace[1174719651] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:263; }","duration":"201.090961ms","start":"2026-05-27T13:51:37.643691Z","end":"2026-05-27T13:51:37.844782Z","steps":["trace[1174719651] 'read index received' (duration: 53.715151ms)","trace[1174719651] 'applied index is now lower than readState.Index' (duration: 147.37318ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:51:37.845039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.288265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:51:37.845087Z","caller":"traceutil/trace.go:171","msg":"trace[773742398] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:0; response_revision:256; }","duration":"201.394838ms","start":"2026-05-27T13:51:37.643679Z","end":"2026-05-27T13:51:37.845074Z","steps":["trace[773742398] 'agreement among raft nodes before linearized reading' (duration: 201.234504ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:38.090568Z","caller":"traceutil/trace.go:171","msg":"trace[1068324213] transaction","detail":"{read_only:false; number_of_response:0; response_revision:256; }","duration":"366.050797ms","start":"2026-05-27T13:51:37.72449Z","end":"2026-05-27T13:51:38.090541Z","steps":["trace[1068324213] 'process raft request' (duration: 365.900114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:38.090839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:37.724479Z","time spent":"366.292941ms","remote":"127.0.0.1:44892","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:51:38.090883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.215747ms","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-05-27T13:51:38.090649Z","caller":"traceutil/trace.go:171","msg":"trace[554736480] linearizableReadLoop","detail":"{readStateIndex:266; appliedIndex:266; }","duration":"245.674109ms","start":"2026-05-27T13:51:37.84488Z","end":"2026-05-27T13:51:38.090554Z","steps":["trace[554736480] 'read index received' (duration: 245.661669ms)","trace[554736480] 'applied index is now lower than readState.Index' (duration: 10.01µs)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:51:38.091146Z","caller":"traceutil/trace.go:171","msg":"trace[1772471464] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:256; }","duration":"368.476682ms","start":"2026-05-27T13:51:37.72257Z","end":"2026-05-27T13:51:38.091047Z","steps":["trace[1772471464] 'agreement among raft nodes before linearized reading' (duration: 368.155886ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:51:38.09143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:51:37.72255Z","time spent":"368.861489ms","remote":"127.0.0.1:44892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":2942,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-05-27T13:51:38.091449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.472605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-27T13:51:38.091558Z","caller":"traceutil/trace.go:171","msg":"trace[1983378483] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:256; }","duration":"243.64634ms","start":"2026-05-27T13:51:37.847881Z","end":"2026-05-27T13:51:38.091527Z","steps":["trace[1983378483] 'agreement among raft nodes before linearized reading' (duration: 243.425175ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:51:38.209677Z","caller":"traceutil/trace.go:171","msg":"trace[1174455087] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"102.786884ms","start":"2026-05-27T13:51:38.106866Z","end":"2026-05-27T13:51:38.209653Z","steps":["trace[1174455087] 'process raft request' (duration: 102.213453ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:14.460045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.811492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-27T13:52:14.460174Z","caller":"traceutil/trace.go:171","msg":"trace[2128005111] linearizableReadLoop","detail":"{readStateIndex:607; appliedIndex:606; }","duration":"434.18508ms","start":"2026-05-27T13:52:14.025967Z","end":"2026-05-27T13:52:14.460152Z","steps":["trace[2128005111] 'read index received' (duration: 188.180215ms)","trace[2128005111] 'applied index is now lower than readState.Index' (duration: 246.003445ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:52:14.460202Z","caller":"traceutil/trace.go:171","msg":"trace[331413586] transaction","detail":"{read_only:false; response_revision:587; number_of_response:1; }","duration":"455.883813ms","start":"2026-05-27T13:52:14.004279Z","end":"2026-05-27T13:52:14.460162Z","steps":["trace[331413586] 'process raft request' (duration: 209.902099ms)","trace[331413586] 'compare' (duration: 245.649677ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:52:14.460328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:14.004258Z","time spent":"456.010325ms","remote":"127.0.0.1:45226","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-27T13:52:14.460364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.380934ms","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-05-27T13:52:14.460422Z","caller":"traceutil/trace.go:171","msg":"trace[388473523] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:587; }","duration":"434.475406ms","start":"2026-05-27T13:52:14.025931Z","end":"2026-05-27T13:52:14.460407Z","steps":["trace[388473523] 'agreement among raft nodes before linearized reading' (duration: 434.279622ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:14.460466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:52:14.025915Z","time spent":"434.538977ms","remote":"127.0.0.1:44980","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":"info","ts":"2026-05-27T13:52:14.681473Z","caller":"traceutil/trace.go:171","msg":"trace[480370180] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"217.617376ms","start":"2026-05-27T13:52:14.463834Z","end":"2026-05-27T13:52:14.681451Z","steps":["trace[480370180] 'process raft request' (duration: 203.213171ms)","trace[480370180] 'compare' (duration: 14.125919ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:52:14.681701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.021242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:52:14.681802Z","caller":"traceutil/trace.go:171","msg":"trace[496643965] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:589; }","duration":"209.243327ms","start":"2026-05-27T13:52:14.472535Z","end":"2026-05-27T13:52:14.681778Z","steps":["trace[496643965] 'agreement among raft nodes before linearized reading' (duration: 209.036103ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:14.682Z","caller":"traceutil/trace.go:171","msg":"trace[815183294] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:607; }","duration":"208.724606ms","start":"2026-05-27T13:52:14.472653Z","end":"2026-05-27T13:52:14.681378Z","steps":["trace[815183294] 'read index received' (duration: 66.615585ms)","trace[815183294] 'applied index is now lower than readState.Index' (duration: 142.106821ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:52:14.682325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.273456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:52:14.682375Z","caller":"traceutil/trace.go:171","msg":"trace[1587186369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"190.377918ms","start":"2026-05-27T13:52:14.491987Z","end":"2026-05-27T13:52:14.682365Z","steps":["trace[1587186369] 'agreement among raft nodes before linearized reading' (duration: 190.295437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:52:14.6826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.180863ms","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-05-27T13:52:14.682842Z","caller":"traceutil/trace.go:171","msg":"trace[1636384969] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:589; }","duration":"101.477019ms","start":"2026-05-27T13:52:14.581345Z","end":"2026-05-27T13:52:14.682822Z","steps":["trace[1636384969] 'agreement among raft nodes before linearized reading' (duration: 100.945658ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:52:28.970364Z","caller":"traceutil/trace.go:171","msg":"trace[1181666979] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"146.44799ms","start":"2026-05-27T13:52:28.823878Z","end":"2026-05-27T13:52:28.970326Z","steps":["trace[1181666979] 'process raft request' (duration: 126.014173ms)","trace[1181666979] 'compare' (duration: 20.146092ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:53:03.63163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.743173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:53:03.631757Z","caller":"traceutil/trace.go:171","msg":"trace[339566982] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:961; }","duration":"139.910586ms","start":"2026-05-27T13:53:03.491822Z","end":"2026-05-27T13:53:03.631732Z","steps":["trace[339566982] 'range keys from in-memory index tree' (duration: 139.60936ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:53:26.296665Z","caller":"traceutil/trace.go:171","msg":"trace[1951647750] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"121.536912ms","start":"2026-05-27T13:53:26.175099Z","end":"2026-05-27T13:53:26.296636Z","steps":["trace[1951647750] 'process raft request' (duration: 103.790078ms)","trace[1951647750] 'compare' (duration: 17.606301ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:53:41.31107Z","caller":"traceutil/trace.go:171","msg":"trace[1413854998] transaction","detail":"{read_only:false; response_revision:1136; number_of_response:1; }","duration":"166.301967ms","start":"2026-05-27T13:53:41.144749Z","end":"2026-05-27T13:53:41.311051Z","steps":["trace[1413854998] 'process raft request' (duration: 166.201895ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:53:56.843952Z","caller":"traceutil/trace.go:171","msg":"trace[1805596147] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"130.687034ms","start":"2026-05-27T13:53:56.713239Z","end":"2026-05-27T13:53:56.843926Z","steps":["trace[1805596147] 'process raft request' (duration: 130.548512ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:00.647842Z","caller":"traceutil/trace.go:171","msg":"trace[235891632] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"235.509432ms","start":"2026-05-27T13:54:00.412277Z","end":"2026-05-27T13:54:00.647786Z","steps":["trace[235891632] 'process raft request' (duration: 150.100171ms)","trace[235891632] 'compare' (duration: 85.244828ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:54:00.868031Z","caller":"traceutil/trace.go:171","msg":"trace[178719048] linearizableReadLoop","detail":"{readStateIndex:1289; appliedIndex:1288; }","duration":"146.772968ms","start":"2026-05-27T13:54:00.721238Z","end":"2026-05-27T13:54:00.868011Z","steps":["trace[178719048] 'read index received' (duration: 145.700118ms)","trace[178719048] 'applied index is now lower than readState.Index' (duration: 1.07216ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:54:00.868158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.902601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-27T13:54:00.868178Z","caller":"traceutil/trace.go:171","msg":"trace[1303999236] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:1242; }","duration":"146.984362ms","start":"2026-05-27T13:54:00.721188Z","end":"2026-05-27T13:54:00.868172Z","steps":["trace[1303999236] 'agreement among raft nodes before linearized reading' (duration: 146.891361ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:00.868404Z","caller":"traceutil/trace.go:171","msg":"trace[904089452] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"446.561442ms","start":"2026-05-27T13:54:00.421804Z","end":"2026-05-27T13:54:00.868366Z","steps":["trace[904089452] 'process raft request' (duration: 445.125815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-27T13:54:00.868816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-27T13:54:00.421783Z","time spent":"446.712704ms","remote":"127.0.0.1:44980","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-27T13:54:09.796598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.857122ms","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-05-27T13:54:09.79669Z","caller":"traceutil/trace.go:171","msg":"trace[616889462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1298; }","duration":"277.010214ms","start":"2026-05-27T13:54:09.519662Z","end":"2026-05-27T13:54:09.796672Z","steps":["trace[616889462] 'range keys from in-memory index tree' (duration: 276.658688ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:09.989495Z","caller":"traceutil/trace.go:171","msg":"trace[1841574287] linearizableReadLoop","detail":"{readStateIndex:1348; appliedIndex:1347; }","duration":"176.071791ms","start":"2026-05-27T13:54:09.813398Z","end":"2026-05-27T13:54:09.98947Z","steps":["trace[1841574287] 'read index received' (duration: 119.042465ms)","trace[1841574287] 'applied index is now lower than readState.Index' (duration: 57.028336ms)"],"step_count":2} {"level":"warn","ts":"2026-05-27T13:54:09.98976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.567437ms","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-05-27T13:54:09.989797Z","caller":"traceutil/trace.go:171","msg":"trace[646694325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1300; }","duration":"179.663078ms","start":"2026-05-27T13:54:09.810123Z","end":"2026-05-27T13:54:09.989786Z","steps":["trace[646694325] 'agreement among raft nodes before linearized reading' (duration: 179.435924ms)"],"step_count":1} {"level":"info","ts":"2026-05-27T13:54:09.989783Z","caller":"traceutil/trace.go:171","msg":"trace[762348404] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"188.848061ms","start":"2026-05-27T13:54:09.800905Z","end":"2026-05-27T13:54:09.989753Z","steps":["trace[762348404] 'process raft request' (duration: 131.48511ms)","trace[762348404] 'compare' (duration: 56.966234ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:56:20.814757Z","caller":"traceutil/trace.go:171","msg":"trace[1288890525] transaction","detail":"{read_only:false; response_revision:1898; number_of_response:1; }","duration":"114.665567ms","start":"2026-05-27T13:56:20.700058Z","end":"2026-05-27T13:56:20.814724Z","steps":["trace[1288890525] 'process raft request' (duration: 70.946001ms)","trace[1288890525] 'compare' (duration: 43.584604ms)"],"step_count":2} {"level":"info","ts":"2026-05-27T13:56:27.61688Z","caller":"traceutil/trace.go:171","msg":"trace[1181498042] transaction","detail":"{read_only:false; response_revision:1932; number_of_response:1; }","duration":"116.768348ms","start":"2026-05-27T13:56:27.500086Z","end":"2026-05-27T13:56:27.616854Z","steps":["trace[1181498042] 'process raft request' (duration: 116.604365ms)"],"step_count":1}