{"level":"warn","ts":"2026-04-21T15:34:42.920829Z","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-21T15:34:42.920926Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.153: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.153:2380","--initial-cluster=instance=https://199.204.45.153:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.153:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.153: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-21T15:34:42.920993Z","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-21T15:34:42.921008Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-21T15:34:42.92103Z","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-21T15:34:42.921662Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"]} {"level":"info","ts":"2026-04-21T15:34:42.921799Z","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.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.153: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-21T15:34:42.925418Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.403245ms"} {"level":"info","ts":"2026-04-21T15:34:42.93167Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"355195d5aae85944","cluster-id":"e424441517bc0b32"} {"level":"info","ts":"2026-04-21T15:34:42.931767Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=()"} {"level":"info","ts":"2026-04-21T15:34:42.931794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 0"} {"level":"info","ts":"2026-04-21T15:34:42.931814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 355195d5aae85944 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-21T15:34:42.931824Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became follower at term 1"} {"level":"info","ts":"2026-04-21T15:34:42.931866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"warn","ts":"2026-04-21T15:34:42.936696Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-21T15:34:42.938681Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-21T15:34:42.939476Z","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-21T15:34:42.941419Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"355195d5aae85944","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-21T15:34:42.941837Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"355195d5aae85944","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-21T15:34:42.941945Z","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-21T15:34:42.941977Z","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-21T15:34:42.941994Z","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-21T15:34:42.942575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 switched to configuration voters=(3842016702051670340)"} {"level":"info","ts":"2026-04-21T15:34:42.942955Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","added-peer-id":"355195d5aae85944","added-peer-peer-urls":["https://199.204.45.153:2380"]} {"level":"info","ts":"2026-04-21T15:34:42.945759Z","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-21T15:34:42.945939Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"355195d5aae85944","initial-advertise-peer-urls":["https://199.204.45.153:2380"],"listen-peer-urls":["https://199.204.45.153:2380"],"advertise-client-urls":["https://199.204.45.153:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.153:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-21T15:34:42.94597Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-21T15:34:42.946028Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-21T15:34:42.946042Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.153:2380"} {"level":"info","ts":"2026-04-21T15:34:43.632613Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 is starting a new election at term 1"} {"level":"info","ts":"2026-04-21T15:34:43.63267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-21T15:34:43.632701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgPreVoteResp from 355195d5aae85944 at term 1"} {"level":"info","ts":"2026-04-21T15:34:43.63272Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became candidate at term 2"} {"level":"info","ts":"2026-04-21T15:34:43.632728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 received MsgVoteResp from 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-21T15:34:43.632739Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"355195d5aae85944 became leader at term 2"} {"level":"info","ts":"2026-04-21T15:34:43.632748Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 355195d5aae85944 elected leader 355195d5aae85944 at term 2"} {"level":"info","ts":"2026-04-21T15:34:43.6343Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"355195d5aae85944","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.153:2379]}","request-path":"/0/members/355195d5aae85944/attributes","cluster-id":"e424441517bc0b32","publish-timeout":"7s"} {"level":"info","ts":"2026-04-21T15:34:43.634345Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:34:43.634437Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:34:43.63467Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-21T15:34:43.634958Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-21T15:34:43.634994Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-21T15:34:43.635462Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e424441517bc0b32","local-member-id":"355195d5aae85944","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:34:43.63552Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:34:43.635541Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-21T15:34:43.636919Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.153:2379"} {"level":"info","ts":"2026-04-21T15:34:43.638189Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-21T15:34:53.724032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.002717ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-21T15:34:53.724376Z","caller":"traceutil/trace.go:171","msg":"trace[1929759929] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"467.216098ms","start":"2026-04-21T15:34:53.257141Z","end":"2026-04-21T15:34:53.724357Z","steps":["trace[1929759929] 'process raft request' (duration: 467.085795ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:34:53.724325Z","caller":"traceutil/trace.go:171","msg":"trace[910360781] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"467.189717ms","start":"2026-04-21T15:34:53.257074Z","end":"2026-04-21T15:34:53.724264Z","steps":["trace[910360781] 'process raft request' (duration: 124.523984ms)","trace[910360781] 'compare' (duration: 341.859053ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:34:53.724523Z","caller":"traceutil/trace.go:171","msg":"trace[2083202746] linearizableReadLoop","detail":"{readStateIndex:339; appliedIndex:336; }","duration":"438.49026ms","start":"2026-04-21T15:34:53.286012Z","end":"2026-04-21T15:34:53.724502Z","steps":["trace[2083202746] 'read index received' (duration: 95.594802ms)","trace[2083202746] 'applied index is now lower than readState.Index' (duration: 342.894648ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:34:53.724534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:53.257051Z","time spent":"467.396403ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":596,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T15:34:53.724698Z","caller":"traceutil/trace.go:171","msg":"trace[753118028] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"467.518866ms","start":"2026-04-21T15:34:53.257173Z","end":"2026-04-21T15:34:53.724692Z","steps":["trace[753118028] 'process raft request' (duration: 467.147387ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:34:53.724724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:53.257126Z","time spent":"467.30042ms","remote":"127.0.0.1:53532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T15:34:53.724801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:53.257157Z","time spent":"467.566227ms","remote":"127.0.0.1:53532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-21T15:34:53.72497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.953172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-04-21T15:34:53.72499Z","caller":"traceutil/trace.go:171","msg":"trace[958390603] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:330; }","duration":"439.011444ms","start":"2026-04-21T15:34:53.285971Z","end":"2026-04-21T15:34:53.724983Z","steps":["trace[958390603] 'agreement among raft nodes before linearized reading' (duration: 438.954052ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:34:53.725004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:53.285959Z","time spent":"439.041974ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"warn","ts":"2026-04-21T15:34:53.7251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.624669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:34:53.725143Z","caller":"traceutil/trace.go:171","msg":"trace[775242582] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:330; }","duration":"415.70617ms","start":"2026-04-21T15:34:53.30942Z","end":"2026-04-21T15:34:53.725127Z","steps":["trace[775242582] 'agreement among raft nodes before linearized reading' (duration: 415.647799ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:34:53.725173Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:53.309399Z","time spent":"415.768592ms","remote":"127.0.0.1:53138","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-21T15:34:53.725351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.465648ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-04-21T15:34:53.725403Z","caller":"traceutil/trace.go:171","msg":"trace[239113094] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:330; }","duration":"392.587342ms","start":"2026-04-21T15:34:53.332801Z","end":"2026-04-21T15:34:53.725388Z","steps":["trace[239113094] 'agreement among raft nodes before linearized reading' (duration: 392.441318ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:34:53.725445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:34:53.332772Z","time spent":"392.665523ms","remote":"127.0.0.1:53360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":208,"request content":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" "} {"level":"info","ts":"2026-04-21T15:34:53.9352Z","caller":"traceutil/trace.go:171","msg":"trace[1751368825] linearizableReadLoop","detail":"{readStateIndex:341; appliedIndex:339; }","duration":"202.103847ms","start":"2026-04-21T15:34:53.733074Z","end":"2026-04-21T15:34:53.935178Z","steps":["trace[1751368825] 'read index received' (duration: 75.985412ms)","trace[1751368825] 'applied index is now lower than readState.Index' (duration: 126.117475ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:34:53.935398Z","caller":"traceutil/trace.go:171","msg":"trace[1147407070] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"202.418695ms","start":"2026-04-21T15:34:53.732956Z","end":"2026-04-21T15:34:53.935374Z","steps":["trace[1147407070] 'process raft request' (duration: 200.482766ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:34:53.935467Z","caller":"traceutil/trace.go:171","msg":"trace[1340379362] transaction","detail":"{read_only:false; response_revision:333; number_of_response:1; }","duration":"200.819254ms","start":"2026-04-21T15:34:53.734634Z","end":"2026-04-21T15:34:53.935454Z","steps":["trace[1340379362] 'process raft request' (duration: 200.288621ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:34:53.93542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.329473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:34:53.935595Z","caller":"traceutil/trace.go:171","msg":"trace[632708049] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:334; }","duration":"202.555658ms","start":"2026-04-21T15:34:53.733029Z","end":"2026-04-21T15:34:53.935585Z","steps":["trace[632708049] 'agreement among raft nodes before linearized reading' (duration: 202.238871ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:34:53.935679Z","caller":"traceutil/trace.go:171","msg":"trace[1594009021] transaction","detail":"{read_only:false; response_revision:334; number_of_response:1; }","duration":"198.121586ms","start":"2026-04-21T15:34:53.737548Z","end":"2026-04-21T15:34:53.93567Z","steps":["trace[1594009021] 'process raft request' (duration: 197.596133ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:35:19.386153Z","caller":"traceutil/trace.go:171","msg":"trace[1847237914] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"147.339011ms","start":"2026-04-21T15:35:19.238763Z","end":"2026-04-21T15:35:19.386102Z","steps":["trace[1847237914] 'process raft request' (duration: 145.911985ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:35:19.884326Z","caller":"traceutil/trace.go:171","msg":"trace[1365773879] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"432.210447ms","start":"2026-04-21T15:35:19.452083Z","end":"2026-04-21T15:35:19.884293Z","steps":["trace[1365773879] 'process raft request' (duration: 432.069464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:35:19.884493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:35:19.452058Z","time spent":"432.371071ms","remote":"127.0.0.1:53734","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-21T15:35:19.884709Z","caller":"traceutil/trace.go:171","msg":"trace[1379906486] linearizableReadLoop","detail":"{readStateIndex:591; appliedIndex:591; }","duration":"365.784579ms","start":"2026-04-21T15:35:19.518895Z","end":"2026-04-21T15:35:19.884679Z","steps":["trace[1379906486] 'read index received' (duration: 365.773288ms)","trace[1379906486] 'applied index is now lower than readState.Index' (duration: 9.251µs)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:35:19.884909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.001424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jzjpj\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-21T15:35:19.884934Z","caller":"traceutil/trace.go:171","msg":"trace[1959088384] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jzjpj; range_end:; response_count:1; response_revision:575; }","duration":"366.078986ms","start":"2026-04-21T15:35:19.518848Z","end":"2026-04-21T15:35:19.884927Z","steps":["trace[1959088384] 'agreement among raft nodes before linearized reading' (duration: 365.922072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:35:19.884955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-21T15:35:19.518831Z","time spent":"366.120008ms","remote":"127.0.0.1:53336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-jzjpj\" "} {"level":"info","ts":"2026-04-21T15:35:35.77738Z","caller":"traceutil/trace.go:171","msg":"trace[1879031980] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"150.159413ms","start":"2026-04-21T15:35:35.627146Z","end":"2026-04-21T15:35:35.777305Z","steps":["trace[1879031980] 'process raft request' (duration: 149.869996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:10.841927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.990466ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:36:10.842002Z","caller":"traceutil/trace.go:171","msg":"trace[1892057842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:952; }","duration":"121.129099ms","start":"2026-04-21T15:36:10.720858Z","end":"2026-04-21T15:36:10.841988Z","steps":["trace[1892057842] 'range keys from in-memory index tree' (duration: 120.897033ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:31.642108Z","caller":"traceutil/trace.go:171","msg":"trace[1793530301] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"120.707809ms","start":"2026-04-21T15:36:31.521373Z","end":"2026-04-21T15:36:31.642081Z","steps":["trace[1793530301] 'process raft request' (duration: 120.529355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:31.893288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.236703ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-21T15:36:32.39065Z","caller":"traceutil/trace.go:171","msg":"trace[537864005] transaction","detail":"{read_only:false; response_revision:1022; number_of_response:1; }","duration":"111.179978ms","start":"2026-04-21T15:36:32.279451Z","end":"2026-04-21T15:36:32.390631Z","steps":["trace[537864005] 'process raft request' (duration: 111.032205ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:33.590605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.937234ms","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-21T15:36:33.590785Z","caller":"traceutil/trace.go:171","msg":"trace[972580462] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1025; }","duration":"176.177459ms","start":"2026-04-21T15:36:33.41458Z","end":"2026-04-21T15:36:33.590758Z","steps":["trace[972580462] 'range keys from in-memory index tree' (duration: 175.741537ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:45.652124Z","caller":"traceutil/trace.go:171","msg":"trace[263757857] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"186.694395ms","start":"2026-04-21T15:36:45.465402Z","end":"2026-04-21T15:36:45.652096Z","steps":["trace[263757857] 'process raft request' (duration: 186.541151ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:36:45.781835Z","caller":"traceutil/trace.go:171","msg":"trace[637754891] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1153; }","duration":"105.127144ms","start":"2026-04-21T15:36:45.676684Z","end":"2026-04-21T15:36:45.781811Z","steps":["trace[637754891] 'read index received' (duration: 102.731253ms)","trace[637754891] 'applied index is now lower than readState.Index' (duration: 2.395061ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:36:45.78203Z","caller":"traceutil/trace.go:171","msg":"trace[679820687] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"113.627709ms","start":"2026-04-21T15:36:45.668387Z","end":"2026-04-21T15:36:45.782015Z","steps":["trace[679820687] 'process raft request' (duration: 111.074845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:36:45.78221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.505033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:36:45.782297Z","caller":"traceutil/trace.go:171","msg":"trace[257909523] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:1116; }","duration":"105.649727ms","start":"2026-04-21T15:36:45.67663Z","end":"2026-04-21T15:36:45.78228Z","steps":["trace[257909523] 'agreement among raft nodes before linearized reading' (duration: 105.318179ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:01.069296Z","caller":"traceutil/trace.go:171","msg":"trace[958821059] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"259.486143ms","start":"2026-04-21T15:37:00.809789Z","end":"2026-04-21T15:37:01.069275Z","steps":["trace[958821059] 'process raft request' (duration: 259.094863ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:01.848832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.686153ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-21T15:37:01.849299Z","caller":"traceutil/trace.go:171","msg":"trace[1601050800] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1224; }","duration":"128.499365ms","start":"2026-04-21T15:37:01.72078Z","end":"2026-04-21T15:37:01.849279Z","steps":["trace[1601050800] 'read index received' (duration: 42.646407ms)","trace[1601050800] 'applied index is now lower than readState.Index' (duration: 85.851488ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:37:01.849428Z","caller":"traceutil/trace.go:171","msg":"trace[936239700] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"168.407943ms","start":"2026-04-21T15:37:01.680991Z","end":"2026-04-21T15:37:01.849399Z","steps":["trace[936239700] 'process raft request' (duration: 167.954292ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:01.918823Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.023932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-21T15:37:01.918912Z","caller":"traceutil/trace.go:171","msg":"trace[1707014452] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1184; }","duration":"198.154135ms","start":"2026-04-21T15:37:01.720737Z","end":"2026-04-21T15:37:01.918891Z","steps":["trace[1707014452] 'agreement among raft nodes before linearized reading' (duration: 128.66618ms)","trace[1707014452] 'range keys from in-memory index tree' (duration: 69.331382ms)"],"step_count":2} {"level":"warn","ts":"2026-04-21T15:37:01.9192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.138317ms","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-21T15:37:01.919274Z","caller":"traceutil/trace.go:171","msg":"trace[1342135212] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1184; }","duration":"168.2653ms","start":"2026-04-21T15:37:01.750991Z","end":"2026-04-21T15:37:01.919256Z","steps":["trace[1342135212] 'agreement among raft nodes before linearized reading' (duration: 98.438876ms)","trace[1342135212] 'range keys from in-memory index tree' (duration: 69.2708ms)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:37:02.683866Z","caller":"traceutil/trace.go:171","msg":"trace[1636790632] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"164.603007ms","start":"2026-04-21T15:37:02.519247Z","end":"2026-04-21T15:37:02.68385Z","steps":["trace[1636790632] 'process raft request' (duration: 164.471114ms)"],"step_count":1} {"level":"warn","ts":"2026-04-21T15:37:02.6841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.414675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"info","ts":"2026-04-21T15:37:02.684124Z","caller":"traceutil/trace.go:171","msg":"trace[581416456] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1191; }","duration":"113.493217ms","start":"2026-04-21T15:37:02.570623Z","end":"2026-04-21T15:37:02.684117Z","steps":["trace[581416456] 'agreement among raft nodes before linearized reading' (duration: 113.393224ms)"],"step_count":1} {"level":"info","ts":"2026-04-21T15:37:02.684349Z","caller":"traceutil/trace.go:171","msg":"trace[1468147670] linearizableReadLoop","detail":"{readStateIndex:1233; appliedIndex:1232; }","duration":"113.140088ms","start":"2026-04-21T15:37:02.570676Z","end":"2026-04-21T15:37:02.683816Z","steps":["trace[1468147670] 'read index received' (duration: 112.995655ms)","trace[1468147670] 'applied index is now lower than readState.Index' (duration: 143.773µs)"],"step_count":2} {"level":"info","ts":"2026-04-21T15:37:02.813678Z","caller":"traceutil/trace.go:171","msg":"trace[1269171831] transaction","detail":"{read_only:false; response_revision:1192; number_of_response:1; }","duration":"120.974255ms","start":"2026-04-21T15:37:02.692673Z","end":"2026-04-21T15:37:02.813647Z","steps":["trace[1269171831] 'process raft request' (duration: 120.706809ms)"],"step_count":1}