{"level":"warn","ts":"2026-04-20T20:53:08.883824Z","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-20T20:53:08.883915Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.249: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.249:2380","--initial-cluster=instance=https://199.19.213.249:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.249:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.249: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-20T20:53:08.88402Z","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-20T20:53:08.88403Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.249:2380"]} {"level":"info","ts":"2026-04-20T20:53:08.884048Z","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-20T20:53:08.886052Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"]} {"level":"info","ts":"2026-04-20T20:53:08.886214Z","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.249:2380"],"listen-peer-urls":["https://199.19.213.249:2380"],"advertise-client-urls":["https://199.19.213.249:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.249: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-20T20:53:08.896691Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.142521ms"} {"level":"info","ts":"2026-04-20T20:53:08.904638Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5835264b86215850","cluster-id":"4e10f3807bdbbd9b"} {"level":"info","ts":"2026-04-20T20:53:08.904923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T20:53:08.904981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became follower at term 0"} {"level":"info","ts":"2026-04-20T20:53:08.90509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5835264b86215850 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T20:53:08.907118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became follower at term 1"} {"level":"info","ts":"2026-04-20T20:53:08.907243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=(6356028554918058064)"} {"level":"warn","ts":"2026-04-20T20:53:08.913972Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T20:53:08.91519Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T20:53:08.916455Z","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-20T20:53:08.918386Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5835264b86215850","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T20:53:08.918685Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5835264b86215850","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T20:53:08.918826Z","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-20T20:53:08.921126Z","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-20T20:53:08.921144Z","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-20T20:53:08.921722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 switched to configuration voters=(6356028554918058064)"} {"level":"info","ts":"2026-04-20T20:53:08.922398Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4e10f3807bdbbd9b","local-member-id":"5835264b86215850","added-peer-id":"5835264b86215850","added-peer-peer-urls":["https://199.19.213.249:2380"]} {"level":"info","ts":"2026-04-20T20:53:08.923406Z","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-20T20:53:08.923562Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.249:2380"} {"level":"info","ts":"2026-04-20T20:53:08.923604Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.249:2380"} {"level":"info","ts":"2026-04-20T20:53:08.923746Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5835264b86215850","initial-advertise-peer-urls":["https://199.19.213.249:2380"],"listen-peer-urls":["https://199.19.213.249:2380"],"advertise-client-urls":["https://199.19.213.249:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.249:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T20:53:08.923804Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T20:53:09.307919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T20:53:09.307986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T20:53:09.30801Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 received MsgPreVoteResp from 5835264b86215850 at term 1"} {"level":"info","ts":"2026-04-20T20:53:09.308027Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became candidate at term 2"} {"level":"info","ts":"2026-04-20T20:53:09.308034Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 received MsgVoteResp from 5835264b86215850 at term 2"} {"level":"info","ts":"2026-04-20T20:53:09.308047Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5835264b86215850 became leader at term 2"} {"level":"info","ts":"2026-04-20T20:53:09.308057Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5835264b86215850 elected leader 5835264b86215850 at term 2"} {"level":"info","ts":"2026-04-20T20:53:09.320667Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:53:09.500506Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5835264b86215850","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.249:2379]}","request-path":"/0/members/5835264b86215850/attributes","cluster-id":"4e10f3807bdbbd9b","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T20:53:09.500912Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T20:53:09.502766Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T20:53:09.502841Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T20:53:09.500876Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T20:53:09.504083Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.249:2379"} {"level":"info","ts":"2026-04-20T20:53:09.505354Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T20:53:09.783881Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4e10f3807bdbbd9b","local-member-id":"5835264b86215850","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:53:09.78406Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T20:53:09.784106Z","caller":"traceutil/trace.go:171","msg":"trace[605038950] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"215.588683ms","start":"2026-04-20T20:53:09.568495Z","end":"2026-04-20T20:53:09.784084Z","steps":["trace[605038950] 'read index received' (duration: 215.311399ms)","trace[605038950] 'applied index is now lower than readState.Index' (duration: 276.444µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:53:09.784186Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-04-20T20:53:09.784414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.888559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.784455Z","caller":"traceutil/trace.go:171","msg":"trace[1264608172] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"215.95659ms","start":"2026-04-20T20:53:09.568489Z","end":"2026-04-20T20:53:09.784446Z","steps":["trace[1264608172] 'agreement among raft nodes before linearized reading' (duration: 215.756737ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.784641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.665465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T20:53:09.784963Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.668666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.78502Z","caller":"traceutil/trace.go:171","msg":"trace[54282936] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"102.731817ms","start":"2026-04-20T20:53:09.682278Z","end":"2026-04-20T20:53:09.78501Z","steps":["trace[54282936] 'agreement among raft nodes before linearized reading' (duration: 102.654586ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:09.784987Z","caller":"traceutil/trace.go:171","msg":"trace[241834073] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"137.056231ms","start":"2026-04-20T20:53:09.647893Z","end":"2026-04-20T20:53:09.784949Z","steps":["trace[241834073] 'agreement among raft nodes before linearized reading' (duration: 136.637244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.785163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.607281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.785263Z","caller":"traceutil/trace.go:171","msg":"trace[931951721] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"137.656301ms","start":"2026-04-20T20:53:09.647533Z","end":"2026-04-20T20:53:09.78519Z","steps":["trace[931951721] 'agreement among raft nodes before linearized reading' (duration: 137.60526ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.785474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.143421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T20:53:09.786184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.255056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.785516Z","caller":"traceutil/trace.go:171","msg":"trace[784881389] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"147.210611ms","start":"2026-04-20T20:53:09.638298Z","end":"2026-04-20T20:53:09.785508Z","steps":["trace[784881389] 'agreement among raft nodes before linearized reading' (duration: 147.15213ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.786572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.479807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.786597Z","caller":"traceutil/trace.go:171","msg":"trace[2134078015] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"104.564108ms","start":"2026-04-20T20:53:09.682027Z","end":"2026-04-20T20:53:09.786591Z","steps":["trace[2134078015] 'agreement among raft nodes before linearized reading' (duration: 104.526857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.786721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.422771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T20:53:09.786749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.866836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.786768Z","caller":"traceutil/trace.go:171","msg":"trace[43811404] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"118.906017ms","start":"2026-04-20T20:53:09.667856Z","end":"2026-04-20T20:53:09.786762Z","steps":["trace[43811404] 'agreement among raft nodes before linearized reading' (duration: 118.872416ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:09.786751Z","caller":"traceutil/trace.go:171","msg":"trace[426911590] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"148.466651ms","start":"2026-04-20T20:53:09.638278Z","end":"2026-04-20T20:53:09.786745Z","steps":["trace[426911590] 'agreement among raft nodes before linearized reading' (duration: 148.419941ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.786885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.396378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.786921Z","caller":"traceutil/trace.go:171","msg":"trace[1309473707] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"170.452428ms","start":"2026-04-20T20:53:09.616457Z","end":"2026-04-20T20:53:09.786909Z","steps":["trace[1309473707] 'agreement among raft nodes before linearized reading' (duration: 170.386497ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.787005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.030039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.787028Z","caller":"traceutil/trace.go:171","msg":"trace[1079426434] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"159.0991ms","start":"2026-04-20T20:53:09.627924Z","end":"2026-04-20T20:53:09.787023Z","steps":["trace[1079426434] 'agreement among raft nodes before linearized reading' (duration: 159.021469ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.7871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.213172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.787192Z","caller":"traceutil/trace.go:171","msg":"trace[1039451119] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"159.320264ms","start":"2026-04-20T20:53:09.627818Z","end":"2026-04-20T20:53:09.787139Z","steps":["trace[1039451119] 'agreement among raft nodes before linearized reading' (duration: 159.162491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:09.784984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.131083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T20:53:09.787567Z","caller":"traceutil/trace.go:171","msg":"trace[926325497] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"218.673755ms","start":"2026-04-20T20:53:09.568777Z","end":"2026-04-20T20:53:09.78745Z","steps":["trace[926325497] 'agreement among raft nodes before linearized reading' (duration: 215.690015ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:09.786224Z","caller":"traceutil/trace.go:171","msg":"trace[1827719180] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"118.305638ms","start":"2026-04-20T20:53:09.667909Z","end":"2026-04-20T20:53:09.786215Z","steps":["trace[1827719180] 'agreement among raft nodes before linearized reading' (duration: 118.246287ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.943191Z","caller":"traceutil/trace.go:171","msg":"trace[1895707267] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"135.315188ms","start":"2026-04-20T20:53:37.807825Z","end":"2026-04-20T20:53:37.94314Z","steps":["trace[1895707267] 'process raft request' (duration: 135.128945ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.949563Z","caller":"traceutil/trace.go:171","msg":"trace[261461508] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"141.034671ms","start":"2026-04-20T20:53:37.808506Z","end":"2026-04-20T20:53:37.94954Z","steps":["trace[261461508] 'process raft request' (duration: 140.872239ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.949715Z","caller":"traceutil/trace.go:171","msg":"trace[1177501925] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"141.074161ms","start":"2026-04-20T20:53:37.808617Z","end":"2026-04-20T20:53:37.949691Z","steps":["trace[1177501925] 'process raft request' (duration: 140.842178ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.949744Z","caller":"traceutil/trace.go:171","msg":"trace[575524245] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"132.529479ms","start":"2026-04-20T20:53:37.817174Z","end":"2026-04-20T20:53:37.949703Z","steps":["trace[575524245] 'process raft request' (duration: 132.312906ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.94972Z","caller":"traceutil/trace.go:171","msg":"trace[2033650541] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"129.219972ms","start":"2026-04-20T20:53:37.82047Z","end":"2026-04-20T20:53:37.94969Z","steps":["trace[2033650541] 'process raft request' (duration: 129.040659ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.949795Z","caller":"traceutil/trace.go:171","msg":"trace[196449222] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"129.275922ms","start":"2026-04-20T20:53:37.820511Z","end":"2026-04-20T20:53:37.949787Z","steps":["trace[196449222] 'process raft request' (duration: 129.032289ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.949864Z","caller":"traceutil/trace.go:171","msg":"trace[1233042665] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"129.313163ms","start":"2026-04-20T20:53:37.820543Z","end":"2026-04-20T20:53:37.949856Z","steps":["trace[1233042665] 'process raft request' (duration: 129.025689ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.949957Z","caller":"traceutil/trace.go:171","msg":"trace[1541744587] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"127.565168ms","start":"2026-04-20T20:53:37.822378Z","end":"2026-04-20T20:53:37.949943Z","steps":["trace[1541744587] 'process raft request' (duration: 127.218554ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.950055Z","caller":"traceutil/trace.go:171","msg":"trace[190360749] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"123.023254ms","start":"2026-04-20T20:53:37.827015Z","end":"2026-04-20T20:53:37.950038Z","steps":["trace[190360749] 'process raft request' (duration: 122.883182ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.950111Z","caller":"traceutil/trace.go:171","msg":"trace[242655897] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"118.894385ms","start":"2026-04-20T20:53:37.831209Z","end":"2026-04-20T20:53:37.950103Z","steps":["trace[242655897] 'process raft request' (duration: 118.747003ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:37.95021Z","caller":"traceutil/trace.go:171","msg":"trace[1516020687] linearizableReadLoop","detail":"{readStateIndex:491; appliedIndex:484; }","duration":"127.931304ms","start":"2026-04-20T20:53:37.822266Z","end":"2026-04-20T20:53:37.950197Z","steps":["trace[1516020687] 'read index received' (duration: 120.836942ms)","trace[1516020687] 'applied index is now lower than readState.Index' (duration: 7.093602ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:53:37.950242Z","caller":"traceutil/trace.go:171","msg":"trace[80065525] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"102.591583ms","start":"2026-04-20T20:53:37.84764Z","end":"2026-04-20T20:53:37.950232Z","steps":["trace[80065525] 'process raft request' (duration: 102.354189ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:37.950309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.028065ms","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-20T20:53:37.950531Z","caller":"traceutil/trace.go:171","msg":"trace[777226724] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:478; }","duration":"128.276869ms","start":"2026-04-20T20:53:37.822247Z","end":"2026-04-20T20:53:37.950523Z","steps":["trace[777226724] 'agreement among raft nodes before linearized reading' (duration: 127.999915ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:42.561872Z","caller":"traceutil/trace.go:171","msg":"trace[508436875] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"403.55662ms","start":"2026-04-20T20:53:42.1583Z","end":"2026-04-20T20:53:42.561857Z","steps":["trace[508436875] 'process raft request' (duration: 401.802366ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:42.562012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.676456ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:53:42.562096Z","caller":"traceutil/trace.go:171","msg":"trace[1065994508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"172.798419ms","start":"2026-04-20T20:53:42.389272Z","end":"2026-04-20T20:53:42.562071Z","steps":["trace[1065994508] 'agreement among raft nodes before linearized reading' (duration: 172.680397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:42.562401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:42.158275Z","time spent":"403.666231ms","remote":"127.0.0.1:58050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T20:53:42.561803Z","caller":"traceutil/trace.go:171","msg":"trace[1722610327] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"172.454624ms","start":"2026-04-20T20:53:42.389325Z","end":"2026-04-20T20:53:42.56178Z","steps":["trace[1722610327] 'read index received' (duration: 170.464146ms)","trace[1722610327] 'applied index is now lower than readState.Index' (duration: 1.989538ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:53:44.218906Z","caller":"traceutil/trace.go:171","msg":"trace[1099081014] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"244.544713ms","start":"2026-04-20T20:53:43.974313Z","end":"2026-04-20T20:53:44.218858Z","steps":["trace[1099081014] 'process raft request' (duration: 228.435699ms)","trace[1099081014] 'compare' (duration: 15.588287ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:53:44.219186Z","caller":"traceutil/trace.go:171","msg":"trace[489475270] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"198.685773ms","start":"2026-04-20T20:53:44.020025Z","end":"2026-04-20T20:53:44.218711Z","steps":["trace[489475270] 'read index received' (duration: 178.612773ms)","trace[489475270] 'applied index is now lower than readState.Index' (duration: 20.07209ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:53:44.219847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.810278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T20:53:44.21993Z","caller":"traceutil/trace.go:171","msg":"trace[2078667882] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"199.93901ms","start":"2026-04-20T20:53:44.019969Z","end":"2026-04-20T20:53:44.219908Z","steps":["trace[2078667882] 'agreement among raft nodes before linearized reading' (duration: 199.742898ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:44.509899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.189642ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T20:53:44.510074Z","caller":"traceutil/trace.go:171","msg":"trace[2108283502] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"285.587803ms","start":"2026-04-20T20:53:44.224464Z","end":"2026-04-20T20:53:44.510052Z","steps":["trace[2108283502] 'process raft request' (duration: 123.973694ms)","trace[2108283502] 'compare' (duration: 161.05239ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:53:44.525464Z","caller":"traceutil/trace.go:171","msg":"trace[927418245] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:595; }","duration":"202.278603ms","start":"2026-04-20T20:53:44.323155Z","end":"2026-04-20T20:53:44.525434Z","steps":["trace[927418245] 'read index received' (duration: 25.21991ms)","trace[927418245] 'applied index is now lower than readState.Index' (duration: 177.057193ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:53:44.525551Z","caller":"traceutil/trace.go:171","msg":"trace[1821364457] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"252.947748ms","start":"2026-04-20T20:53:44.272579Z","end":"2026-04-20T20:53:44.525527Z","steps":["trace[1821364457] 'process raft request' (duration: 252.715035ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:44.525909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.73218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9p9hb\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-04-20T20:53:44.525986Z","caller":"traceutil/trace.go:171","msg":"trace[691350841] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9p9hb; range_end:; response_count:1; response_revision:576; }","duration":"202.858991ms","start":"2026-04-20T20:53:44.323114Z","end":"2026-04-20T20:53:44.525973Z","steps":["trace[691350841] 'agreement among raft nodes before linearized reading' (duration: 202.483816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:44.526167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.040107ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:53:44.526253Z","caller":"traceutil/trace.go:171","msg":"trace[196171821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"137.537533ms","start":"2026-04-20T20:53:44.388695Z","end":"2026-04-20T20:53:44.526233Z","steps":["trace[196171821] 'agreement among raft nodes before linearized reading' (duration: 136.949415ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:45.334774Z","caller":"traceutil/trace.go:171","msg":"trace[1433209386] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"794.918043ms","start":"2026-04-20T20:53:44.539835Z","end":"2026-04-20T20:53:45.334753Z","steps":["trace[1433209386] 'process raft request' (duration: 776.746491ms)","trace[1433209386] 'compare' (duration: 18.070331ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:53:45.334895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:44.539819Z","time spent":"795.013374ms","remote":"127.0.0.1:58160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T20:53:46.429662Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.111438944s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T20:53:46.491697Z","caller":"traceutil/trace.go:171","msg":"trace[859025028] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"1.899575807s","start":"2026-04-20T20:53:44.592078Z","end":"2026-04-20T20:53:46.491654Z","steps":["trace[859025028] 'process raft request' (duration: 1.837843203s)","trace[859025028] 'compare' (duration: 61.019324ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:53:46.492174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:44.592049Z","time spent":"1.899724028s","remote":"127.0.0.1:58210","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T20:53:46.493557Z","caller":"traceutil/trace.go:171","msg":"trace[448755208] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"1.568589363s","start":"2026-04-20T20:53:44.924935Z","end":"2026-04-20T20:53:46.493524Z","steps":["trace[448755208] 'process raft request' (duration: 1.566738847s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:46.493735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:44.924908Z","time spent":"1.568736395s","remote":"127.0.0.1:58050","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T20:53:46.49377Z","caller":"traceutil/trace.go:171","msg":"trace[1862330966] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"1.402100601s","start":"2026-04-20T20:53:45.091645Z","end":"2026-04-20T20:53:46.493746Z","steps":["trace[1862330966] 'process raft request' (duration: 1.401742676s)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:46.493748Z","caller":"traceutil/trace.go:171","msg":"trace[498227592] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:597; }","duration":"1.325835814s","start":"2026-04-20T20:53:45.167875Z","end":"2026-04-20T20:53:46.49371Z","steps":["trace[498227592] 'read index received' (duration: 148.810284ms)","trace[498227592] 'applied index is now lower than readState.Index' (duration: 1.17702286s)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:53:46.493838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:45.091619Z","time spent":"1.402186763s","remote":"127.0.0.1:58158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T20:53:46.494003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323765954s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-20T20:53:46.494032Z","caller":"traceutil/trace.go:171","msg":"trace[245896709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:580; }","duration":"1.323823446s","start":"2026-04-20T20:53:45.170201Z","end":"2026-04-20T20:53:46.494024Z","steps":["trace[245896709] 'agreement among raft nodes before linearized reading' (duration: 1.323725744s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:46.494053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:45.170184Z","time spent":"1.323864666s","remote":"127.0.0.1:58210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T20:53:46.494076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105215254s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T20:53:46.494086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.326178258s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-20T20:53:46.49418Z","caller":"traceutil/trace.go:171","msg":"trace[104849187] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:580; }","duration":"1.32627402s","start":"2026-04-20T20:53:45.16784Z","end":"2026-04-20T20:53:46.494114Z","steps":["trace[104849187] 'agreement among raft nodes before linearized reading' (duration: 1.326058257s)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:46.494197Z","caller":"traceutil/trace.go:171","msg":"trace[102241645] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"1.105299006s","start":"2026-04-20T20:53:45.388809Z","end":"2026-04-20T20:53:46.494108Z","steps":["trace[102241645] 'agreement among raft nodes before linearized reading' (duration: 1.105235355s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:46.494242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:45.38877Z","time spent":"1.105462578s","remote":"127.0.0.1:57960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T20:53:46.494232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126220275s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-20T20:53:46.494239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:45.167823Z","time spent":"1.326404012s","remote":"127.0.0.1:58210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T20:53:46.494283Z","caller":"traceutil/trace.go:171","msg":"trace[1660831402] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:580; }","duration":"1.126310146s","start":"2026-04-20T20:53:45.36796Z","end":"2026-04-20T20:53:46.49427Z","steps":["trace[1660831402] 'agreement among raft nodes before linearized reading' (duration: 1.126113863s)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:53:46.494324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:53:45.367939Z","time spent":"1.126377698s","remote":"127.0.0.1:58210","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-04-20T20:53:47.638593Z","caller":"traceutil/trace.go:171","msg":"trace[631953256] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"183.202615ms","start":"2026-04-20T20:53:47.455358Z","end":"2026-04-20T20:53:47.63856Z","steps":["trace[631953256] 'process raft request' (duration: 177.091001ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:53:51.659136Z","caller":"traceutil/trace.go:171","msg":"trace[337173189] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"125.971357ms","start":"2026-04-20T20:53:51.533132Z","end":"2026-04-20T20:53:51.659104Z","steps":["trace[337173189] 'process raft request' (duration: 125.023944ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:03.7229Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.047995254s","expected-duration":"1s"} {"level":"info","ts":"2026-04-20T20:54:03.723487Z","caller":"traceutil/trace.go:171","msg":"trace[847778806] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:771; }","duration":"334.507854ms","start":"2026-04-20T20:54:03.38894Z","end":"2026-04-20T20:54:03.723448Z","steps":["trace[847778806] 'read index received' (duration: 334.38961ms)","trace[847778806] 'applied index is now lower than readState.Index' (duration: 116.544µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T20:54:03.723516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:54:02.674762Z","time spent":"1.048746499s","remote":"127.0.0.1:57986","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-20T20:54:03.723849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.867608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T20:54:03.72402Z","caller":"traceutil/trace.go:171","msg":"trace[1887614135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:746; }","duration":"335.046165ms","start":"2026-04-20T20:54:03.388898Z","end":"2026-04-20T20:54:03.723945Z","steps":["trace[1887614135] 'agreement among raft nodes before linearized reading' (duration: 334.861658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:03.724112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T20:54:03.38888Z","time spent":"335.218891ms","remote":"127.0.0.1:57960","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T20:54:03.725248Z","caller":"traceutil/trace.go:171","msg":"trace[1485006947] transaction","detail":"{read_only:false; response_revision:747; number_of_response:1; }","duration":"284.236868ms","start":"2026-04-20T20:54:03.440998Z","end":"2026-04-20T20:54:03.725234Z","steps":["trace[1485006947] 'process raft request' (duration: 284.096193ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:54:16.797558Z","caller":"traceutil/trace.go:171","msg":"trace[157296990] transaction","detail":"{read_only:false; response_revision:904; number_of_response:1; }","duration":"123.397207ms","start":"2026-04-20T20:54:16.674121Z","end":"2026-04-20T20:54:16.797518Z","steps":["trace[157296990] 'process raft request' (duration: 123.115017ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T20:54:16.800542Z","caller":"traceutil/trace.go:171","msg":"trace[1089391509] linearizableReadLoop","detail":"{readStateIndex:934; appliedIndex:932; }","duration":"122.120233ms","start":"2026-04-20T20:54:16.678392Z","end":"2026-04-20T20:54:16.800512Z","steps":["trace[1089391509] 'read index received' (duration: 118.894343ms)","trace[1089391509] 'applied index is now lower than readState.Index' (duration: 3.224399ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T20:54:16.800582Z","caller":"traceutil/trace.go:171","msg":"trace[1355099817] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"124.606407ms","start":"2026-04-20T20:54:16.675954Z","end":"2026-04-20T20:54:16.80056Z","steps":["trace[1355099817] 'process raft request' (duration: 124.364179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:16.800844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.431274ms","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-20T20:54:16.800888Z","caller":"traceutil/trace.go:171","msg":"trace[1644186140] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:905; }","duration":"122.520326ms","start":"2026-04-20T20:54:16.678357Z","end":"2026-04-20T20:54:16.800877Z","steps":["trace[1644186140] 'agreement among raft nodes before linearized reading' (duration: 122.306389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T20:54:16.801104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.942337ms","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-04-20T20:54:16.801183Z","caller":"traceutil/trace.go:171","msg":"trace[942055911] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:905; }","duration":"122.054061ms","start":"2026-04-20T20:54:16.679105Z","end":"2026-04-20T20:54:16.801159Z","steps":["trace[942055911] 'agreement among raft nodes before linearized reading' (duration: 121.579564ms)"],"step_count":1}