{"level":"warn","ts":"2026-04-02T08:45:31.356317Z","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-02T08:45:31.356474Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.69: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.69:2380","--initial-cluster=instance=https://199.204.45.69:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.69:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.69: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-02T08:45:31.356584Z","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-02T08:45:31.356607Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-04-02T08:45:31.35664Z","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-02T08:45:31.357861Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"]} {"level":"info","ts":"2026-04-02T08:45:31.357994Z","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.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.69: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-02T08:45:31.363084Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.706616ms"} {"level":"info","ts":"2026-04-02T08:45:31.377372Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"fe334179879fd0aa","cluster-id":"d79a8cccc23ced73"} {"level":"info","ts":"2026-04-02T08:45:31.377573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T08:45:31.377672Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 0"} {"level":"info","ts":"2026-04-02T08:45:31.377695Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft fe334179879fd0aa [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T08:45:31.37775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became follower at term 1"} {"level":"info","ts":"2026-04-02T08:45:31.37785Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"warn","ts":"2026-04-02T08:45:31.388522Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T08:45:31.390048Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T08:45:31.39135Z","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-02T08:45:31.396816Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"fe334179879fd0aa","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T08:45:31.397006Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"fe334179879fd0aa","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T08:45:31.397316Z","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-02T08:45:31.397407Z","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-02T08:45:31.397419Z","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-02T08:45:31.399325Z","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-02T08:45:31.399512Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-04-02T08:45:31.399531Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.69:2380"} {"level":"info","ts":"2026-04-02T08:45:31.399616Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"fe334179879fd0aa","initial-advertise-peer-urls":["https://199.204.45.69:2380"],"listen-peer-urls":["https://199.204.45.69:2380"],"advertise-client-urls":["https://199.204.45.69:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.69:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T08:45:31.399653Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T08:45:31.40089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa switched to configuration voters=(18317056099668185258)"} {"level":"info","ts":"2026-04-02T08:45:31.40108Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","added-peer-id":"fe334179879fd0aa","added-peer-peer-urls":["https://199.204.45.69:2380"]} {"level":"info","ts":"2026-04-02T08:45:32.079181Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T08:45:32.079222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T08:45:32.079245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgPreVoteResp from fe334179879fd0aa at term 1"} {"level":"info","ts":"2026-04-02T08:45:32.079256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became candidate at term 2"} {"level":"info","ts":"2026-04-02T08:45:32.079261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa received MsgVoteResp from fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-04-02T08:45:32.079268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"fe334179879fd0aa became leader at term 2"} {"level":"info","ts":"2026-04-02T08:45:32.079275Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: fe334179879fd0aa elected leader fe334179879fd0aa at term 2"} {"level":"info","ts":"2026-04-02T08:45:32.080128Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T08:45:32.080915Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"fe334179879fd0aa","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.69:2379]}","request-path":"/0/members/fe334179879fd0aa/attributes","cluster-id":"d79a8cccc23ced73","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T08:45:32.080974Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T08:45:32.080997Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T08:45:32.086195Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.69:2379"} {"level":"info","ts":"2026-04-02T08:45:32.086444Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T08:45:32.082416Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"d79a8cccc23ced73","local-member-id":"fe334179879fd0aa","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T08:45:32.092629Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T08:45:32.107316Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T08:45:32.107752Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T08:45:32.107792Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T08:45:33.476582Z","caller":"traceutil/trace.go:171","msg":"trace[1105316276] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"163.900913ms","start":"2026-04-02T08:45:33.312661Z","end":"2026-04-02T08:45:33.476562Z","steps":["trace[1105316276] 'process raft request' (duration: 163.684737ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.715887Z","caller":"traceutil/trace.go:171","msg":"trace[901619577] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"402.213055ms","start":"2026-04-02T08:45:33.313644Z","end":"2026-04-02T08:45:33.715857Z","steps":["trace[901619577] 'process raft request' (duration: 402.107622ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.715907Z","caller":"traceutil/trace.go:171","msg":"trace[1489544392] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"403.024237ms","start":"2026-04-02T08:45:33.312791Z","end":"2026-04-02T08:45:33.715815Z","steps":["trace[1489544392] 'process raft request' (duration: 402.826082ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.71599Z","caller":"traceutil/trace.go:171","msg":"trace[2128976536] linearizableReadLoop","detail":"{readStateIndex:7; appliedIndex:4; }","duration":"390.505427ms","start":"2026-04-02T08:45:33.325471Z","end":"2026-04-02T08:45:33.715976Z","steps":["trace[2128976536] 'read index received' (duration: 151.031125ms)","trace[2128976536] 'applied index is now lower than readState.Index' (duration: 239.473712ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:45:33.716055Z","caller":"traceutil/trace.go:171","msg":"trace[783753943] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"337.952802ms","start":"2026-04-02T08:45:33.378095Z","end":"2026-04-02T08:45:33.716048Z","steps":["trace[783753943] 'process raft request' (duration: 337.727366ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.716103Z","caller":"traceutil/trace.go:171","msg":"trace[28771619] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"337.84606ms","start":"2026-04-02T08:45:33.378251Z","end":"2026-04-02T08:45:33.716097Z","steps":["trace[28771619] 'process raft request' (duration: 337.608213ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.716129Z","caller":"traceutil/trace.go:171","msg":"trace[1175298875] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"337.589822ms","start":"2026-04-02T08:45:33.378534Z","end":"2026-04-02T08:45:33.716124Z","steps":["trace[1175298875] 'process raft request' (duration: 337.343796ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.716153Z","caller":"traceutil/trace.go:171","msg":"trace[1476662356] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"337.48172ms","start":"2026-04-02T08:45:33.378666Z","end":"2026-04-02T08:45:33.716148Z","steps":["trace[1476662356] 'process raft request' (duration: 337.227653ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.716174Z","caller":"traceutil/trace.go:171","msg":"trace[973489495] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"337.286635ms","start":"2026-04-02T08:45:33.378882Z","end":"2026-04-02T08:45:33.716169Z","steps":["trace[973489495] 'process raft request' (duration: 337.029608ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.716348Z","caller":"traceutil/trace.go:171","msg":"trace[526330490] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"316.45719ms","start":"2026-04-02T08:45:33.399884Z","end":"2026-04-02T08:45:33.716341Z","steps":["trace[526330490] 'process raft request' (duration: 316.046409ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.716466Z","caller":"traceutil/trace.go:171","msg":"trace[730848277] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"316.515162ms","start":"2026-04-02T08:45:33.399926Z","end":"2026-04-02T08:45:33.716441Z","steps":["trace[730848277] 'process raft request' (duration: 316.027329ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:33.716504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.399917Z","time spent":"316.566153ms","remote":"127.0.0.1:45034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:33.71656Z","caller":"traceutil/trace.go:171","msg":"trace[2070816698] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"338.404795ms","start":"2026-04-02T08:45:33.378085Z","end":"2026-04-02T08:45:33.71649Z","steps":["trace[2070816698] 'process raft request' (duration: 337.698006ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:33.716654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.378067Z","time spent":"338.005914ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:33.716788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.378067Z","time spent":"338.619871ms","remote":"127.0.0.1:45314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:33.716815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.080523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-04-02T08:45:33.716781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.248527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T08:45:33.716846Z","caller":"traceutil/trace.go:171","msg":"trace[342131584] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"339.145845ms","start":"2026-04-02T08:45:33.377692Z","end":"2026-04-02T08:45:33.716838Z","steps":["trace[342131584] 'agreement among raft nodes before linearized reading' (duration: 339.089553ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:33.716853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.431283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-04-02T08:45:33.716881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.377671Z","time spent":"339.204587ms","remote":"127.0.0.1:44964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-04-02T08:45:33.716877Z","caller":"traceutil/trace.go:171","msg":"trace[1046658795] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:12; }","duration":"391.420932ms","start":"2026-04-02T08:45:33.325441Z","end":"2026-04-02T08:45:33.716862Z","steps":["trace[1046658795] 'agreement among raft nodes before linearized reading' (duration: 391.162965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:33.716894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.378244Z","time spent":"337.87369ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:33.716797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.336279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.69\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T08:45:33.716938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.325428Z","time spent":"391.479034ms","remote":"127.0.0.1:45244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":28,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-02T08:45:33.716977Z","caller":"traceutil/trace.go:171","msg":"trace[830999930] range","detail":"{range_begin:/registry/masterleases/199.204.45.69; range_end:; response_count:0; response_revision:12; }","duration":"336.576985ms","start":"2026-04-02T08:45:33.380383Z","end":"2026-04-02T08:45:33.71696Z","steps":["trace[830999930] 'agreement among raft nodes before linearized reading' (duration: 336.313688ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:33.717064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.38037Z","time spent":"336.669468ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":28,"request content":"key:\"/registry/masterleases/199.204.45.69\" "} {"level":"warn","ts":"2026-04-02T08:45:33.717114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.37865Z","time spent":"337.51379ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:33.717079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.378528Z","time spent":"337.614884ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:33.71728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.431923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-04-02T08:45:33.717321Z","caller":"traceutil/trace.go:171","msg":"trace[1177558384] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"353.546395ms","start":"2026-04-02T08:45:33.363343Z","end":"2026-04-02T08:45:33.716889Z","steps":["trace[1177558384] 'agreement among raft nodes before linearized reading' (duration: 353.339119ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:33.717364Z","caller":"traceutil/trace.go:171","msg":"trace[291999965] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"287.546757ms","start":"2026-04-02T08:45:33.429804Z","end":"2026-04-02T08:45:33.717351Z","steps":["trace[291999965] 'agreement among raft nodes before linearized reading' (duration: 287.444084ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:33.717478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.363324Z","time spent":"354.134922ms","remote":"127.0.0.1:44964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-04-02T08:45:33.717333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.378872Z","time spent":"337.310455ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:33.717651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.312774Z","time spent":"403.258343ms","remote":"127.0.0.1:44924","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:45:33.71773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.399856Z","time spent":"316.508112ms","remote":"127.0.0.1:45106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:33.717437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.313636Z","time spent":"402.331698ms","remote":"127.0.0.1:44964","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:34.060968Z","caller":"traceutil/trace.go:171","msg":"trace[355266253] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"332.759101ms","start":"2026-04-02T08:45:33.728184Z","end":"2026-04-02T08:45:34.060943Z","steps":["trace[355266253] 'process raft request' (duration: 267.289957ms)","trace[355266253] 'compare' (duration: 65.33238ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:34.061118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728148Z","time spent":"332.894995ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:34.268187Z","caller":"traceutil/trace.go:171","msg":"trace[780460709] linearizableReadLoop","detail":"{readStateIndex:18; appliedIndex:15; }","duration":"539.890447ms","start":"2026-04-02T08:45:33.728273Z","end":"2026-04-02T08:45:34.268163Z","steps":["trace[780460709] 'read index received' (duration: 267.212184ms)","trace[780460709] 'applied index is now lower than readState.Index' (duration: 272.677223ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:45:34.268439Z","caller":"traceutil/trace.go:171","msg":"trace[732083904] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"540.178595ms","start":"2026-04-02T08:45:33.728252Z","end":"2026-04-02T08:45:34.268431Z","steps":["trace[732083904] 'process raft request' (duration: 539.635721ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.268583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728241Z","time spent":"540.275418ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:34.26863Z","caller":"traceutil/trace.go:171","msg":"trace[53926498] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"540.215166ms","start":"2026-04-02T08:45:33.728382Z","end":"2026-04-02T08:45:34.268597Z","steps":["trace[53926498] 'process raft request' (duration: 539.559948ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:34.268678Z","caller":"traceutil/trace.go:171","msg":"trace[1742532665] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"539.165618ms","start":"2026-04-02T08:45:33.729486Z","end":"2026-04-02T08:45:34.268652Z","steps":["trace[1742532665] 'process raft request' (duration: 538.563972ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.268776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728372Z","time spent":"540.32378ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:34.268847Z","caller":"traceutil/trace.go:171","msg":"trace[840561554] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"533.608628ms","start":"2026-04-02T08:45:33.735129Z","end":"2026-04-02T08:45:34.268738Z","steps":["trace[840561554] 'process raft request' (duration: 532.96386ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.268818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.729476Z","time spent":"539.261091ms","remote":"127.0.0.1:45314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:34.268998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.735108Z","time spent":"533.801383ms","remote":"127.0.0.1:45034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:45:34.269151Z","caller":"traceutil/trace.go:171","msg":"trace[1320734790] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"539.707723ms","start":"2026-04-02T08:45:33.729428Z","end":"2026-04-02T08:45:34.269135Z","steps":["trace[1320734790] 'process raft request' (duration: 538.599442ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:34.268868Z","caller":"traceutil/trace.go:171","msg":"trace[2063104495] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"540.050702ms","start":"2026-04-02T08:45:33.728498Z","end":"2026-04-02T08:45:34.268548Z","steps":["trace[2063104495] 'process raft request' (duration: 539.474696ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:34.268327Z","caller":"traceutil/trace.go:171","msg":"trace[1171528422] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"539.722603ms","start":"2026-04-02T08:45:33.728575Z","end":"2026-04-02T08:45:34.268298Z","steps":["trace[1171528422] 'process raft request' (duration: 539.427265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.26944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728558Z","time spent":"540.845534ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:34.268392Z","caller":"traceutil/trace.go:171","msg":"trace[1601686231] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"540.153115ms","start":"2026-04-02T08:45:33.728227Z","end":"2026-04-02T08:45:34.26838Z","steps":["trace[1601686231] 'process raft request' (duration: 498.844509ms)","trace[1601686231] 'compare' (duration: 40.636048ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:34.269595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.306787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3490"} {"level":"warn","ts":"2026-04-02T08:45:34.269685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728209Z","time spent":"541.421259ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:34.269231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.729416Z","time spent":"539.781164ms","remote":"127.0.0.1:45406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:34.26948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728491Z","time spent":"540.754402ms","remote":"127.0.0.1:44962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":357,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:34.269772Z","caller":"traceutil/trace.go:171","msg":"trace[265619274] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:21; }","duration":"541.46941ms","start":"2026-04-02T08:45:33.72824Z","end":"2026-04-02T08:45:34.269709Z","steps":["trace[265619274] 'agreement among raft nodes before linearized reading' (duration: 540.855614ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.269307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.922715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T08:45:34.269969Z","caller":"traceutil/trace.go:171","msg":"trace[719568476] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:21; }","duration":"541.600144ms","start":"2026-04-02T08:45:33.728332Z","end":"2026-04-02T08:45:34.269932Z","steps":["trace[719568476] 'agreement among raft nodes before linearized reading' (duration: 540.896435ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.270041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728324Z","time spent":"541.700957ms","remote":"127.0.0.1:44962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"warn","ts":"2026-04-02T08:45:34.269344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.856814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T08:45:34.270159Z","caller":"traceutil/trace.go:171","msg":"trace[1336424072] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:21; }","duration":"541.733698ms","start":"2026-04-02T08:45:33.728399Z","end":"2026-04-02T08:45:34.270133Z","steps":["trace[1336424072] 'agreement among raft nodes before linearized reading' (duration: 540.905825ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.270237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728375Z","time spent":"541.841171ms","remote":"127.0.0.1:44936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" "} {"level":"warn","ts":"2026-04-02T08:45:34.270007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:33.728225Z","time spent":"541.694487ms","remote":"127.0.0.1:45034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3514,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-02T08:45:34.435153Z","caller":"traceutil/trace.go:171","msg":"trace[1315154212] transaction","detail":"{read_only:false; response_revision:50; number_of_response:1; }","duration":"108.339793ms","start":"2026-04-02T08:45:34.326785Z","end":"2026-04-02T08:45:34.435125Z","steps":["trace[1315154212] 'process raft request' (duration: 108.300362ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:34.435888Z","caller":"traceutil/trace.go:171","msg":"trace[399210029] transaction","detail":"{read_only:false; response_revision:48; number_of_response:1; }","duration":"110.506363ms","start":"2026-04-02T08:45:34.325366Z","end":"2026-04-02T08:45:34.435873Z","steps":["trace[399210029] 'process raft request' (duration: 61.676231ms)","trace[399210029] 'compare' (duration: 47.811614ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:45:34.436017Z","caller":"traceutil/trace.go:171","msg":"trace[116008952] linearizableReadLoop","detail":"{readStateIndex:51; appliedIndex:50; }","duration":"110.293297ms","start":"2026-04-02T08:45:34.325714Z","end":"2026-04-02T08:45:34.436007Z","steps":["trace[116008952] 'read index received' (duration: 61.342333ms)","trace[116008952] 'applied index is now lower than readState.Index' (duration: 48.950064ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:34.436082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.345479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T08:45:34.436113Z","caller":"traceutil/trace.go:171","msg":"trace[350699334] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:50; }","duration":"110.4012ms","start":"2026-04-02T08:45:34.3257Z","end":"2026-04-02T08:45:34.436101Z","steps":["trace[350699334] 'agreement among raft nodes before linearized reading' (duration: 110.340348ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:34.436235Z","caller":"traceutil/trace.go:171","msg":"trace[2054362859] transaction","detail":"{read_only:false; response_revision:49; number_of_response:1; }","duration":"110.212345ms","start":"2026-04-02T08:45:34.326014Z","end":"2026-04-02T08:45:34.436226Z","steps":["trace[2054362859] 'process raft request' (duration: 109.007252ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:34.868998Z","caller":"traceutil/trace.go:171","msg":"trace[1971423222] linearizableReadLoop","detail":"{readStateIndex:54; appliedIndex:53; }","duration":"427.754671ms","start":"2026-04-02T08:45:34.441219Z","end":"2026-04-02T08:45:34.868974Z","steps":["trace[1971423222] 'read index received' (duration: 427.649898ms)","trace[1971423222] 'applied index is now lower than readState.Index' (duration: 103.703µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:45:34.869143Z","caller":"traceutil/trace.go:171","msg":"trace[641604738] transaction","detail":"{read_only:false; response_revision:51; number_of_response:1; }","duration":"428.563703ms","start":"2026-04-02T08:45:34.440549Z","end":"2026-04-02T08:45:34.869113Z","steps":["trace[641604738] 'process raft request' (duration: 428.314676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.869236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.008838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/system-node-high\" ","response":"range_response_count:1 size:1132"} {"level":"info","ts":"2026-04-02T08:45:34.869301Z","caller":"traceutil/trace.go:171","msg":"trace[1419624512] range","detail":"{range_begin:/registry/flowschemas/system-node-high; range_end:; response_count:1; response_revision:51; }","duration":"428.105191ms","start":"2026-04-02T08:45:34.441182Z","end":"2026-04-02T08:45:34.869287Z","steps":["trace[1419624512] 'agreement among raft nodes before linearized reading' (duration: 427.949567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:34.869324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:34.441171Z","time spent":"428.147872ms","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":1,"response size":1156,"request content":"key:\"/registry/flowschemas/system-node-high\" "} {"level":"warn","ts":"2026-04-02T08:45:34.869308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:34.440531Z","time spent":"428.704877ms","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":779,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:35.199374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.925024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-02T08:45:35.199705Z","caller":"traceutil/trace.go:171","msg":"trace[1341305592] transaction","detail":"{read_only:false; response_revision:52; number_of_response:1; }","duration":"757.647064ms","start":"2026-04-02T08:45:34.441995Z","end":"2026-04-02T08:45:35.199642Z","steps":["trace[1341305592] 'process raft request' (duration: 555.203586ms)","trace[1341305592] 'compare' (duration: 201.75421ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:45:35.199781Z","caller":"traceutil/trace.go:171","msg":"trace[753899650] transaction","detail":"{read_only:false; response_revision:54; number_of_response:1; }","duration":"326.621974ms","start":"2026-04-02T08:45:34.873143Z","end":"2026-04-02T08:45:35.199765Z","steps":["trace[753899650] 'process raft request' (duration: 326.549522ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:35.199879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:34.873131Z","time spent":"326.691036ms","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1059,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:45:35.199963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:34.441986Z","time spent":"757.85267ms","remote":"127.0.0.1:45200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":634,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:35.200073Z","caller":"traceutil/trace.go:171","msg":"trace[1270111183] linearizableReadLoop","detail":"{readStateIndex:55; appliedIndex:54; }","duration":"330.946162ms","start":"2026-04-02T08:45:34.869082Z","end":"2026-04-02T08:45:35.200028Z","steps":["trace[1270111183] 'read index received' (duration: 128.133133ms)","trace[1270111183] 'applied index is now lower than readState.Index' (duration: 202.808129ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:35.20014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.159299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T08:45:35.200117Z","caller":"traceutil/trace.go:171","msg":"trace[1700677271] transaction","detail":"{read_only:false; response_revision:53; number_of_response:1; }","duration":"327.643902ms","start":"2026-04-02T08:45:34.872443Z","end":"2026-04-02T08:45:35.200087Z","steps":["trace[1700677271] 'process raft request' (duration: 327.191059ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:35.200188Z","caller":"traceutil/trace.go:171","msg":"trace[785037542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:54; }","duration":"473.265102ms","start":"2026-04-02T08:45:34.726913Z","end":"2026-04-02T08:45:35.200178Z","steps":["trace[785037542] 'agreement among raft nodes before linearized reading' (duration: 473.166409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:35.20019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.085667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-02T08:45:35.200213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:34.726894Z","time spent":"473.313413ms","remote":"127.0.0.1:44848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T08:45:35.200233Z","caller":"traceutil/trace.go:171","msg":"trace[1731140632] range","detail":"{range_begin:/registry/limitranges/kube-system/; range_end:/registry/limitranges/kube-system0; response_count:0; response_revision:54; }","duration":"703.167419ms","start":"2026-04-02T08:45:34.49704Z","end":"2026-04-02T08:45:35.200207Z","steps":["trace[1731140632] 'agreement among raft nodes before linearized reading' (duration: 703.086637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:35.200264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:34.872415Z","time spent":"327.783116ms","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":826,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:35.200278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:34.497021Z","time spent":"703.250622ms","remote":"127.0.0.1:44992","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/limitranges/kube-system/\" range_end:\"/registry/limitranges/kube-system0\" "} {"level":"warn","ts":"2026-04-02T08:45:35.910685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.65606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-02T08:45:35.91096Z","caller":"traceutil/trace.go:171","msg":"trace[566801813] transaction","detail":"{read_only:false; response_revision:55; number_of_response:1; }","duration":"708.627575ms","start":"2026-04-02T08:45:35.202287Z","end":"2026-04-02T08:45:35.910914Z","steps":["trace[566801813] 'process raft request' (duration: 314.645725ms)","trace[566801813] 'compare' (duration: 393.504556ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:35.911047Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:35.202266Z","time spent":"708.741938ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:35.911208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"708.800769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:monitoring\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T08:45:35.911257Z","caller":"traceutil/trace.go:171","msg":"trace[1680669220] range","detail":"{range_begin:/registry/clusterroles/system:monitoring; range_end:; response_count:0; response_revision:55; }","duration":"708.883822ms","start":"2026-04-02T08:45:35.20236Z","end":"2026-04-02T08:45:35.911243Z","steps":["trace[1680669220] 'agreement among raft nodes before linearized reading' (duration: 708.722067ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:35.911294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:35.202344Z","time spent":"708.938053ms","remote":"127.0.0.1:45200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/clusterroles/system:monitoring\" "} {"level":"info","ts":"2026-04-02T08:45:35.911308Z","caller":"traceutil/trace.go:171","msg":"trace[1535791270] linearizableReadLoop","detail":"{readStateIndex:58; appliedIndex:57; }","duration":"708.46412ms","start":"2026-04-02T08:45:35.202393Z","end":"2026-04-02T08:45:35.910857Z","steps":["trace[1535791270] 'read index received' (duration: 314.553012ms)","trace[1535791270] 'applied index is now lower than readState.Index' (duration: 393.909488ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:45:35.945595Z","caller":"traceutil/trace.go:171","msg":"trace[125004189] transaction","detail":"{read_only:false; response_revision:56; number_of_response:1; }","duration":"743.020557ms","start":"2026-04-02T08:45:35.202541Z","end":"2026-04-02T08:45:35.945561Z","steps":["trace[125004189] 'process raft request' (duration: 742.855602ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:35.945748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:35.202525Z","time spent":"743.123109ms","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:35.945758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"618.580836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-02T08:45:35.945763Z","caller":"traceutil/trace.go:171","msg":"trace[1589378772] transaction","detail":"{read_only:false; response_revision:57; number_of_response:1; }","duration":"743.12818ms","start":"2026-04-02T08:45:35.2026Z","end":"2026-04-02T08:45:35.945728Z","steps":["trace[1589378772] 'process raft request' (duration: 742.881743ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:35.945912Z","caller":"traceutil/trace.go:171","msg":"trace[1299374520] transaction","detail":"{read_only:false; response_revision:58; number_of_response:1; }","duration":"742.821451ms","start":"2026-04-02T08:45:35.203075Z","end":"2026-04-02T08:45:35.945896Z","steps":["trace[1299374520] 'process raft request' (duration: 742.462311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:35.94593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:35.202586Z","time spent":"743.266654ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2905,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:35.945986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:35.203068Z","time spent":"742.868973ms","remote":"127.0.0.1:45300","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1216,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:45:35.945814Z","caller":"traceutil/trace.go:171","msg":"trace[1236002071] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:58; }","duration":"618.675868ms","start":"2026-04-02T08:45:35.327121Z","end":"2026-04-02T08:45:35.945797Z","steps":["trace[1236002071] 'agreement among raft nodes before linearized reading' (duration: 618.483783ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:35.946075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:35.327097Z","time spent":"618.954146ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T08:45:49.199766Z","caller":"traceutil/trace.go:171","msg":"trace[1589209793] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"593.633621ms","start":"2026-04-02T08:45:48.606114Z","end":"2026-04-02T08:45:49.199748Z","steps":["trace[1589209793] 'process raft request' (duration: 593.524857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:49.199885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:48.606087Z","time spent":"593.743864ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4645,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:45:49.199916Z","caller":"traceutil/trace.go:171","msg":"trace[1757749682] linearizableReadLoop","detail":"{readStateIndex:429; appliedIndex:429; }","duration":"498.120977ms","start":"2026-04-02T08:45:48.701775Z","end":"2026-04-02T08:45:49.199896Z","steps":["trace[1757749682] 'read index received' (duration: 498.111657ms)","trace[1757749682] 'applied index is now lower than readState.Index' (duration: 7.52µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:49.200069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.289302ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:45:49.200123Z","caller":"traceutil/trace.go:171","msg":"trace[119043215] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:415; }","duration":"498.374844ms","start":"2026-04-02T08:45:48.701733Z","end":"2026-04-02T08:45:49.200108Z","steps":["trace[119043215] 'agreement among raft nodes before linearized reading' (duration: 498.269411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:49.200161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:48.701711Z","time spent":"498.440866ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T08:45:49.200602Z","caller":"traceutil/trace.go:171","msg":"trace[1088721054] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"225.706859ms","start":"2026-04-02T08:45:48.974879Z","end":"2026-04-02T08:45:49.200586Z","steps":["trace[1088721054] 'process raft request' (duration: 225.486163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:49.200633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.102581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-02T08:45:49.200696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.26249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T08:45:49.200721Z","caller":"traceutil/trace.go:171","msg":"trace[1305580643] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:416; }","duration":"400.257985ms","start":"2026-04-02T08:45:48.800439Z","end":"2026-04-02T08:45:49.200697Z","steps":["trace[1305580643] 'agreement among raft nodes before linearized reading' (duration: 400.089281ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:49.200766Z","caller":"traceutil/trace.go:171","msg":"trace[1424239722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:416; }","duration":"395.330952ms","start":"2026-04-02T08:45:48.805426Z","end":"2026-04-02T08:45:49.200757Z","steps":["trace[1424239722] 'agreement among raft nodes before linearized reading' (duration: 395.24883ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:49.20079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:48.800419Z","time spent":"400.356388ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T08:45:49.20081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:48.805393Z","time spent":"395.390214ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T08:45:54.563594Z","caller":"traceutil/trace.go:171","msg":"trace[1111620767] transaction","detail":"{read_only:false; response_revision:433; number_of_response:1; }","duration":"103.997363ms","start":"2026-04-02T08:45:54.459572Z","end":"2026-04-02T08:45:54.56357Z","steps":["trace[1111620767] 'process raft request' (duration: 103.853159ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:54.726417Z","caller":"traceutil/trace.go:171","msg":"trace[170465325] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"152.796548ms","start":"2026-04-02T08:45:54.57359Z","end":"2026-04-02T08:45:54.726386Z","steps":["trace[170465325] 'process raft request' (duration: 152.652754ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:54.772287Z","caller":"traceutil/trace.go:171","msg":"trace[2096263033] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"123.957358ms","start":"2026-04-02T08:45:54.648289Z","end":"2026-04-02T08:45:54.772247Z","steps":["trace[2096263033] 'process raft request' (duration: 123.67903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:55.274223Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553145285,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:45:55.775009Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553145285,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:45:56.275209Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553145285,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:45:56.561215Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.789249846s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-02T08:45:56.774054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000705211s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-02T08:45:56.774133Z","caller":"traceutil/trace.go:171","msg":"trace[853070768] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000828675s","start":"2026-04-02T08:45:54.773286Z","end":"2026-04-02T08:45:56.774115Z","steps":["trace[853070768] 'agreement among raft nodes before linearized reading' (duration: 2.000734412s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:56.77418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:54.773268Z","time spent":"2.000901017s","remote":"127.0.0.1:44848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/02 08:45:56 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-02T08:45:58.039238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.477705524s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T08:45:58.03951Z","caller":"traceutil/trace.go:171","msg":"trace[47399305] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"1.262120476s","start":"2026-04-02T08:45:56.777373Z","end":"2026-04-02T08:45:58.039493Z","steps":["trace[47399305] 'process raft request' (duration: 1.262084625s)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.039489Z","caller":"traceutil/trace.go:171","msg":"trace[1560853898] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"3.307433558s","start":"2026-04-02T08:45:54.732004Z","end":"2026-04-02T08:45:58.039438Z","steps":["trace[1560853898] 'process raft request' (duration: 1.829460096s)","trace[1560853898] 'compare' (duration: 1.47725338s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:58.039569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:56.777337Z","time spent":"1.262208238s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:45:58.039693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:54.731981Z","time spent":"3.307603843s","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:58.039819Z","caller":"traceutil/trace.go:171","msg":"trace[595610988] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"3.307067237s","start":"2026-04-02T08:45:54.732743Z","end":"2026-04-02T08:45:58.03981Z","steps":["trace[595610988] 'process raft request' (duration: 3.306589443s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.039866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:54.732713Z","time spent":"3.307133109s","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3563,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:58.039925Z","caller":"traceutil/trace.go:171","msg":"trace[1317784076] linearizableReadLoop","detail":"{readStateIndex:453; appliedIndex:450; }","duration":"3.266550548s","start":"2026-04-02T08:45:54.773325Z","end":"2026-04-02T08:45:58.039875Z","steps":["trace[1317784076] 'read index received' (duration: 1.78804832s)","trace[1317784076] 'applied index is now lower than readState.Index' (duration: 1.478486508s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:58.040255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.803250341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-02T08:45:58.040258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.812591911s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-04-02T08:45:58.040289Z","caller":"traceutil/trace.go:171","msg":"trace[1099127390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:439; }","duration":"2.803320703s","start":"2026-04-02T08:45:55.236959Z","end":"2026-04-02T08:45:58.04028Z","steps":["trace[1099127390] 'agreement among raft nodes before linearized reading' (duration: 2.803246801s)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.04031Z","caller":"traceutil/trace.go:171","msg":"trace[454978954] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:439; }","duration":"2.812714915s","start":"2026-04-02T08:45:55.227582Z","end":"2026-04-02T08:45:58.040297Z","steps":["trace[454978954] 'agreement among raft nodes before linearized reading' (duration: 2.81256007s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.040287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.310551491s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.69\" ","response":"range_response_count:1 size:133"} {"level":"warn","ts":"2026-04-02T08:45:58.040363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.258991492s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:45:58.040358Z","caller":"traceutil/trace.go:171","msg":"trace[1745078951] range","detail":"{range_begin:/registry/masterleases/199.204.45.69; range_end:; response_count:1; response_revision:439; }","duration":"1.310649604s","start":"2026-04-02T08:45:56.729692Z","end":"2026-04-02T08:45:58.040342Z","steps":["trace[1745078951] 'agreement among raft nodes before linearized reading' (duration: 1.310467359s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.040349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:55.227554Z","time spent":"2.812787417s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-02T08:45:58.040417Z","caller":"traceutil/trace.go:171","msg":"trace[2118367068] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:439; }","duration":"1.259049043s","start":"2026-04-02T08:45:56.781331Z","end":"2026-04-02T08:45:58.04038Z","steps":["trace[2118367068] 'agreement among raft nodes before linearized reading' (duration: 1.259011532s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.04044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:56.781308Z","time spent":"1.259127496s","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T08:45:58.040374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.808171029s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-02T08:45:58.040439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.246227974s","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-02T08:45:58.040522Z","caller":"traceutil/trace.go:171","msg":"trace[1498120517] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:439; }","duration":"2.808359174s","start":"2026-04-02T08:45:55.232118Z","end":"2026-04-02T08:45:58.040477Z","steps":["trace[1498120517] 'agreement among raft nodes before linearized reading' (duration: 2.808180739s)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.040527Z","caller":"traceutil/trace.go:171","msg":"trace[1500403000] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:439; }","duration":"2.246371058s","start":"2026-04-02T08:45:55.794136Z","end":"2026-04-02T08:45:58.040507Z","steps":["trace[1500403000] 'agreement among raft nodes before linearized reading' (duration: 2.246164912s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.040414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:56.729675Z","time spent":"1.310731497s","remote":"127.0.0.1:44894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":157,"request content":"key:\"/registry/masterleases/199.204.45.69\" "} {"level":"warn","ts":"2026-04-02T08:45:58.040561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:55.232088Z","time spent":"2.808463648s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T08:45:58.040567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:55.794114Z","time spent":"2.246443981s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T08:45:58.040321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:55.236948Z","time spent":"2.803366474s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T08:45:58.040442Z","caller":"traceutil/trace.go:171","msg":"trace[1430597809] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"3.304571123s","start":"2026-04-02T08:45:54.735779Z","end":"2026-04-02T08:45:58.04035Z","steps":["trace[1430597809] 'process raft request' (duration: 3.303627094s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.055616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:54.735765Z","time spent":"3.319708321s","remote":"127.0.0.1:45318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:45:58.363948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.042861Z","time spent":"321.082605ms","remote":"127.0.0.1:44894","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-02T08:45:58.364174Z","caller":"traceutil/trace.go:171","msg":"trace[721906618] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"305.596056ms","start":"2026-04-02T08:45:58.058548Z","end":"2026-04-02T08:45:58.364144Z","steps":["trace[721906618] 'process raft request' (duration: 305.428181ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.364232Z","caller":"traceutil/trace.go:171","msg":"trace[557045604] transaction","detail":"{read_only:false; response_revision:442; number_of_response:1; }","duration":"304.159313ms","start":"2026-04-02T08:45:58.060044Z","end":"2026-04-02T08:45:58.364203Z","steps":["trace[557045604] 'process raft request' (duration: 304.07081ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.364289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.058523Z","time spent":"305.71163ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:45:58.36432Z","caller":"traceutil/trace.go:171","msg":"trace[757916866] linearizableReadLoop","detail":"{readStateIndex:462; appliedIndex:454; }","duration":"300.221264ms","start":"2026-04-02T08:45:58.064089Z","end":"2026-04-02T08:45:58.36431Z","steps":["trace[757916866] 'read index received' (duration: 292.549152ms)","trace[757916866] 'applied index is now lower than readState.Index' (duration: 7.671582ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:45:58.3644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.310447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T08:45:58.364397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.060031Z","time spent":"304.254777ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:45:58.364459Z","caller":"traceutil/trace.go:171","msg":"trace[505595890] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"302.457502ms","start":"2026-04-02T08:45:58.061995Z","end":"2026-04-02T08:45:58.364452Z","steps":["trace[505595890] 'process raft request' (duration: 302.196534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.364512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.061984Z","time spent":"302.502183ms","remote":"127.0.0.1:45352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3804,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:45:58.364635Z","caller":"traceutil/trace.go:171","msg":"trace[1183030362] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"299.396729ms","start":"2026-04-02T08:45:58.065229Z","end":"2026-04-02T08:45:58.364626Z","steps":["trace[1183030362] 'process raft request' (duration: 299.026888ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.364682Z","caller":"traceutil/trace.go:171","msg":"trace[873731422] transaction","detail":"{read_only:false; response_revision:443; number_of_response:1; }","duration":"304.000888ms","start":"2026-04-02T08:45:58.060663Z","end":"2026-04-02T08:45:58.364664Z","steps":["trace[873731422] 'process raft request' (duration: 303.475942ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.364742Z","caller":"traceutil/trace.go:171","msg":"trace[562375581] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"302.490663ms","start":"2026-04-02T08:45:58.062242Z","end":"2026-04-02T08:45:58.364733Z","steps":["trace[562375581] 'process raft request' (duration: 301.990448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.36478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.06065Z","time spent":"304.080691ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:45:58.364798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.062235Z","time spent":"302.524744ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:45:58.364844Z","caller":"traceutil/trace.go:171","msg":"trace[1389349136] transaction","detail":"{read_only:false; response_revision:441; number_of_response:1; }","duration":"305.729341ms","start":"2026-04-02T08:45:58.059097Z","end":"2026-04-02T08:45:58.364827Z","steps":["trace[1389349136] 'process raft request' (duration: 304.979408ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.364862Z","caller":"traceutil/trace.go:171","msg":"trace[2128441246] transaction","detail":"{read_only:false; response_revision:444; number_of_response:1; }","duration":"303.789482ms","start":"2026-04-02T08:45:58.061065Z","end":"2026-04-02T08:45:58.364855Z","steps":["trace[2128441246] 'process raft request' (duration: 303.098301ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:45:58.364705Z","caller":"traceutil/trace.go:171","msg":"trace[2141460754] transaction","detail":"{read_only:false; response_revision:448; number_of_response:1; }","duration":"298.281485ms","start":"2026-04-02T08:45:58.066411Z","end":"2026-04-02T08:45:58.364693Z","steps":["trace[2141460754] 'process raft request' (duration: 297.870032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.364906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.06105Z","time spent":"303.831534ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4037,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:45:58.364928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.059082Z","time spent":"305.800373ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:45:58.36443Z","caller":"traceutil/trace.go:171","msg":"trace[1051504226] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:448; }","duration":"300.365629ms","start":"2026-04-02T08:45:58.064057Z","end":"2026-04-02T08:45:58.364423Z","steps":["trace[1051504226] 'agreement among raft nodes before linearized reading' (duration: 300.289066ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:45:58.365071Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:45:58.064047Z","time spent":"301.015958ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T08:46:08.621949Z","caller":"traceutil/trace.go:171","msg":"trace[140856440] linearizableReadLoop","detail":"{readStateIndex:542; appliedIndex:541; }","duration":"210.601762ms","start":"2026-04-02T08:46:08.411321Z","end":"2026-04-02T08:46:08.621923Z","steps":["trace[140856440] 'read index received' (duration: 210.419306ms)","trace[140856440] 'applied index is now lower than readState.Index' (duration: 180.826µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:46:08.622082Z","caller":"traceutil/trace.go:171","msg":"trace[1366588724] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"211.901652ms","start":"2026-04-02T08:46:08.410163Z","end":"2026-04-02T08:46:08.622065Z","steps":["trace[1366588724] 'process raft request' (duration: 211.558272ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:08.622296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.951913ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T08:46:08.622356Z","caller":"traceutil/trace.go:171","msg":"trace[1353701000] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:523; }","duration":"211.086177ms","start":"2026-04-02T08:46:08.411254Z","end":"2026-04-02T08:46:08.62234Z","steps":["trace[1353701000] 'agreement among raft nodes before linearized reading' (duration: 210.817269ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:08.625376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.297983ms","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-02T08:46:08.625443Z","caller":"traceutil/trace.go:171","msg":"trace[375033169] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:524; }","duration":"210.390285ms","start":"2026-04-02T08:46:08.415036Z","end":"2026-04-02T08:46:08.625427Z","steps":["trace[375033169] 'agreement among raft nodes before linearized reading' (duration: 210.267342ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:08.625492Z","caller":"traceutil/trace.go:171","msg":"trace[797928810] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"211.395716ms","start":"2026-04-02T08:46:08.414066Z","end":"2026-04-02T08:46:08.625461Z","steps":["trace[797928810] 'process raft request' (duration: 211.140978ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.140041Z","caller":"traceutil/trace.go:171","msg":"trace[605117075] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"179.229175ms","start":"2026-04-02T08:46:08.96079Z","end":"2026-04-02T08:46:09.140019Z","steps":["trace[605117075] 'process raft request' (duration: 179.08406ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.275408Z","caller":"traceutil/trace.go:171","msg":"trace[1989664725] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"302.05314ms","start":"2026-04-02T08:46:08.973301Z","end":"2026-04-02T08:46:09.275354Z","steps":["trace[1989664725] 'process raft request' (duration: 301.328137ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.275446Z","caller":"traceutil/trace.go:171","msg":"trace[948541200] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"310.549495ms","start":"2026-04-02T08:46:08.964861Z","end":"2026-04-02T08:46:09.275411Z","steps":["trace[948541200] 'process raft request' (duration: 309.633866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:09.275582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:08.973277Z","time spent":"302.232626ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:46:09.275594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:08.964845Z","time spent":"310.676789ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:46:09.275699Z","caller":"traceutil/trace.go:171","msg":"trace[1167162476] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"301.204484ms","start":"2026-04-02T08:46:08.974487Z","end":"2026-04-02T08:46:09.275691Z","steps":["trace[1167162476] 'process raft request' (duration: 300.183132ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:09.275744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:08.974474Z","time spent":"301.250445ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:46:09.275823Z","caller":"traceutil/trace.go:171","msg":"trace[592372722] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"298.037724ms","start":"2026-04-02T08:46:08.977775Z","end":"2026-04-02T08:46:09.275813Z","steps":["trace[592372722] 'process raft request' (duration: 296.972101ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.275851Z","caller":"traceutil/trace.go:171","msg":"trace[819473241] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"266.83313ms","start":"2026-04-02T08:46:09.008996Z","end":"2026-04-02T08:46:09.27583Z","steps":["trace[819473241] 'process raft request' (duration: 266.737147ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.27589Z","caller":"traceutil/trace.go:171","msg":"trace[1750947127] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"300.647586ms","start":"2026-04-02T08:46:08.975234Z","end":"2026-04-02T08:46:09.275881Z","steps":["trace[1750947127] 'process raft request' (duration: 299.475699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:09.275925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:08.97514Z","time spent":"300.766289ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:46:09.275977Z","caller":"traceutil/trace.go:171","msg":"trace[869356888] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"266.912313ms","start":"2026-04-02T08:46:09.009057Z","end":"2026-04-02T08:46:09.27597Z","steps":["trace[869356888] 'process raft request' (duration: 266.715047ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.276019Z","caller":"traceutil/trace.go:171","msg":"trace[14906742] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"213.113109ms","start":"2026-04-02T08:46:09.062894Z","end":"2026-04-02T08:46:09.276007Z","steps":["trace[14906742] 'process raft request' (duration: 213.058138ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.276041Z","caller":"traceutil/trace.go:171","msg":"trace[876991581] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"253.111951ms","start":"2026-04-02T08:46:09.022922Z","end":"2026-04-02T08:46:09.276034Z","steps":["trace[876991581] 'process raft request' (duration: 252.887764ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.276109Z","caller":"traceutil/trace.go:171","msg":"trace[1241165075] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"238.021778ms","start":"2026-04-02T08:46:09.038079Z","end":"2026-04-02T08:46:09.2761Z","steps":["trace[1241165075] 'process raft request' (duration: 237.796531ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.298246Z","caller":"traceutil/trace.go:171","msg":"trace[711059910] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"153.493804ms","start":"2026-04-02T08:46:09.144723Z","end":"2026-04-02T08:46:09.298217Z","steps":["trace[711059910] 'process raft request' (duration: 153.306068ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.298314Z","caller":"traceutil/trace.go:171","msg":"trace[224097868] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"134.052955ms","start":"2026-04-02T08:46:09.16425Z","end":"2026-04-02T08:46:09.298303Z","steps":["trace[224097868] 'process raft request' (duration: 134.000774ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.298535Z","caller":"traceutil/trace.go:171","msg":"trace[1635122894] transaction","detail":"{read_only:false; number_of_response:1; response_revision:539; }","duration":"137.928536ms","start":"2026-04-02T08:46:09.160574Z","end":"2026-04-02T08:46:09.298503Z","steps":["trace[1635122894] 'process raft request' (duration: 137.618287ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:09.298609Z","caller":"traceutil/trace.go:171","msg":"trace[1026679117] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"152.360988ms","start":"2026-04-02T08:46:09.146022Z","end":"2026-04-02T08:46:09.298383Z","steps":["trace[1026679117] 'process raft request' (duration: 152.11558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:10.200953Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553145499,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:10.556027Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.158513862s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-02T08:46:10.661311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.870111ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T08:46:10.662067Z","caller":"traceutil/trace.go:171","msg":"trace[1547239399] linearizableReadLoop","detail":"{readStateIndex:585; appliedIndex:580; }","duration":"961.982133ms","start":"2026-04-02T08:46:09.700065Z","end":"2026-04-02T08:46:10.662047Z","steps":["trace[1547239399] 'read index received' (duration: 856.296196ms)","trace[1547239399] 'applied index is now lower than readState.Index' (duration: 105.684977ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:46:10.662184Z","caller":"traceutil/trace.go:171","msg":"trace[354561450] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"1.232016093s","start":"2026-04-02T08:46:09.430155Z","end":"2026-04-02T08:46:10.662171Z","steps":["trace[354561450] 'process raft request' (duration: 1.231677712s)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:10.66219Z","caller":"traceutil/trace.go:171","msg":"trace[417016580] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"1.25112447s","start":"2026-04-02T08:46:09.410963Z","end":"2026-04-02T08:46:10.662088Z","steps":["trace[417016580] 'process raft request' (duration: 1.250548232s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:10.662481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:09.41094Z","time spent":"1.25141931s","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10855,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:10.662791Z","caller":"traceutil/trace.go:171","msg":"trace[2048664264] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"903.534183ms","start":"2026-04-02T08:46:09.759235Z","end":"2026-04-02T08:46:10.662769Z","steps":["trace[2048664264] 'process raft request' (duration: 902.757709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:10.662918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:09.759212Z","time spent":"903.635946ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:46:10.662282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:09.430119Z","time spent":"1.232109295s","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:10.663055Z","caller":"traceutil/trace.go:171","msg":"trace[475159777] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"1.265669745s","start":"2026-04-02T08:46:09.397375Z","end":"2026-04-02T08:46:10.663045Z","steps":["trace[475159777] 'process raft request' (duration: 1.158948186s)","trace[475159777] 'compare' (duration: 104.622483ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:46:10.663105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:09.397348Z","time spent":"1.265729057s","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:10.663077Z","caller":"traceutil/trace.go:171","msg":"trace[1506498605] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.252102641s","start":"2026-04-02T08:46:09.410933Z","end":"2026-04-02T08:46:10.663035Z","steps":["trace[1506498605] 'process raft request' (duration: 1.25049632s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:10.663244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:09.410912Z","time spent":"1.252246446s","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:46:10.663655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.583082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:10.663742Z","caller":"traceutil/trace.go:171","msg":"trace[689996784] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:561; }","duration":"963.705866ms","start":"2026-04-02T08:46:09.700015Z","end":"2026-04-02T08:46:10.663721Z","steps":["trace[689996784] 'agreement among raft nodes before linearized reading' (duration: 962.282822ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:10.663785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:09.699994Z","time spent":"963.780569ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T08:46:12.199735Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553145553,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:12.47269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"594.939918ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:12.472855Z","caller":"traceutil/trace.go:171","msg":"trace[1018935755] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:602; }","duration":"595.126354ms","start":"2026-04-02T08:46:11.877707Z","end":"2026-04-02T08:46:12.472834Z","steps":["trace[1018935755] 'range keys from in-memory index tree' (duration: 594.918877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:12.472891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.598868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:151236"} {"level":"info","ts":"2026-04-02T08:46:12.473014Z","caller":"traceutil/trace.go:171","msg":"trace[1987543616] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:602; }","duration":"786.790024ms","start":"2026-04-02T08:46:11.686194Z","end":"2026-04-02T08:46:12.472985Z","steps":["trace[1987543616] 'range keys from in-memory index tree' (duration: 786.33039ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:12.473073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:11.686172Z","time spent":"786.888048ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":1,"response size":151260,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/httproutes.gateway.networking.k8s.io\" "} {"level":"info","ts":"2026-04-02T08:46:12.485849Z","caller":"traceutil/trace.go:171","msg":"trace[1924190089] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"794.181888ms","start":"2026-04-02T08:46:11.691633Z","end":"2026-04-02T08:46:12.485815Z","steps":["trace[1924190089] 'process raft request' (duration: 793.837917ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:12.486062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:11.691618Z","time spent":"794.334832ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:12.502435Z","caller":"traceutil/trace.go:171","msg":"trace[175616970] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"803.441101ms","start":"2026-04-02T08:46:11.698947Z","end":"2026-04-02T08:46:12.502388Z","steps":["trace[175616970] 'read index received' (duration: 786.510657ms)","trace[175616970] 'applied index is now lower than readState.Index' (duration: 16.929374ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:46:12.502505Z","caller":"traceutil/trace.go:171","msg":"trace[30317163] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"719.362735ms","start":"2026-04-02T08:46:11.783109Z","end":"2026-04-02T08:46:12.502472Z","steps":["trace[30317163] 'process raft request' (duration: 718.912391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:12.502647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:11.78307Z","time spent":"719.494149ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570090,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:46:12.502623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.634977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:12.502721Z","caller":"traceutil/trace.go:171","msg":"trace[830656362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"803.771761ms","start":"2026-04-02T08:46:11.698922Z","end":"2026-04-02T08:46:12.502694Z","steps":["trace[830656362] 'agreement among raft nodes before linearized reading' (duration: 803.572955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:12.502761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:11.698912Z","time spent":"803.842653ms","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T08:46:17.476974Z","caller":"traceutil/trace.go:171","msg":"trace[1187588287] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"483.120941ms","start":"2026-04-02T08:46:16.993806Z","end":"2026-04-02T08:46:17.476927Z","steps":["trace[1187588287] 'process raft request' (duration: 479.941779ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:17.47725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:16.993775Z","time spent":"483.382629ms","remote":"127.0.0.1:44952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:17.875226Z","caller":"traceutil/trace.go:171","msg":"trace[1630838878] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:663; }","duration":"175.035121ms","start":"2026-04-02T08:46:17.700168Z","end":"2026-04-02T08:46:17.875203Z","steps":["trace[1630838878] 'read index received' (duration: 174.819834ms)","trace[1630838878] 'applied index is now lower than readState.Index' (duration: 214.157µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:46:17.875418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.227667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:17.875573Z","caller":"traceutil/trace.go:171","msg":"trace[1825461022] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"339.195564ms","start":"2026-04-02T08:46:17.536313Z","end":"2026-04-02T08:46:17.875509Z","steps":["trace[1825461022] 'process raft request' (duration: 338.75981ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:17.875628Z","caller":"traceutil/trace.go:171","msg":"trace[999562218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"175.409533ms","start":"2026-04-02T08:46:17.700126Z","end":"2026-04-02T08:46:17.875536Z","steps":["trace[999562218] 'agreement among raft nodes before linearized reading' (duration: 175.168795ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:17.875781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:17.536274Z","time spent":"339.421482ms","remote":"127.0.0.1:45208","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:46:18.778832Z","caller":"traceutil/trace.go:171","msg":"trace[163539161] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"491.991483ms","start":"2026-04-02T08:46:18.286805Z","end":"2026-04-02T08:46:18.778797Z","steps":["trace[163539161] 'process raft request' (duration: 491.149156ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:18.779002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:18.286756Z","time spent":"492.157517ms","remote":"127.0.0.1:44952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:46:21.433304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.55964953s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T08:46:21.433627Z","caller":"traceutil/trace.go:171","msg":"trace[666360641] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"2.649883769s","start":"2026-04-02T08:46:18.783703Z","end":"2026-04-02T08:46:21.433587Z","steps":["trace[666360641] 'process raft request' (duration: 89.831296ms)","trace[666360641] 'compare' (duration: 2.559395282s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:46:21.4338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:18.783684Z","time spent":"2.650024254s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:21.433841Z","caller":"traceutil/trace.go:171","msg":"trace[2024287417] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"655.947579ms","start":"2026-04-02T08:46:20.777876Z","end":"2026-04-02T08:46:21.433824Z","steps":["trace[2024287417] 'process raft request' (duration: 655.903347ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:21.433923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:20.777836Z","time spent":"656.053433ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:21.434125Z","caller":"traceutil/trace.go:171","msg":"trace[1489661359] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"2.649725114s","start":"2026-04-02T08:46:18.784388Z","end":"2026-04-02T08:46:21.434113Z","steps":["trace[1489661359] 'process raft request' (duration: 2.649149826s)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:21.434161Z","caller":"traceutil/trace.go:171","msg":"trace[839554466] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"2.57743178s","start":"2026-04-02T08:46:18.8567Z","end":"2026-04-02T08:46:21.434131Z","steps":["trace[839554466] 'process raft request' (duration: 2.577037147s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:21.434211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:18.784352Z","time spent":"2.649822017s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:21.434253Z","caller":"traceutil/trace.go:171","msg":"trace[1779422677] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"2.648931399s","start":"2026-04-02T08:46:18.785293Z","end":"2026-04-02T08:46:21.434224Z","steps":["trace[1779422677] 'process raft request' (duration: 2.64834808s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:21.43428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:18.856663Z","time spent":"2.577554803s","remote":"127.0.0.1:45380","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:46:21.434354Z","caller":"traceutil/trace.go:171","msg":"trace[119456951] linearizableReadLoop","detail":"{readStateIndex:670; appliedIndex:665; }","duration":"1.733268039s","start":"2026-04-02T08:46:19.701073Z","end":"2026-04-02T08:46:21.434341Z","steps":["trace[119456951] 'read index received' (duration: 47.342µs)","trace[119456951] 'applied index is now lower than readState.Index' (duration: 1.733219537s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:46:21.434393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:18.785278Z","time spent":"2.649033982s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:21.434518Z","caller":"traceutil/trace.go:171","msg":"trace[1594387015] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"2.649202438s","start":"2026-04-02T08:46:18.785306Z","end":"2026-04-02T08:46:21.434509Z","steps":["trace[1594387015] 'process raft request' (duration: 2.648386182s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:21.434572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:18.785282Z","time spent":"2.649260129s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:46:21.436117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.735044996s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:21.436167Z","caller":"traceutil/trace.go:171","msg":"trace[2061925778] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.735098278s","start":"2026-04-02T08:46:19.701054Z","end":"2026-04-02T08:46:21.436152Z","steps":["trace[2061925778] 'agreement among raft nodes before linearized reading' (duration: 1.733325731s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:21.436203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:19.700987Z","time spent":"1.735207892s","remote":"127.0.0.1:44848","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-02T08:46:21.863028Z","caller":"traceutil/trace.go:171","msg":"trace[1338147197] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"126.405635ms","start":"2026-04-02T08:46:21.736597Z","end":"2026-04-02T08:46:21.863003Z","steps":["trace[1338147197] 'process raft request' (duration: 122.809069ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:22.08824Z","caller":"traceutil/trace.go:171","msg":"trace[163211283] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"101.754227ms","start":"2026-04-02T08:46:21.986461Z","end":"2026-04-02T08:46:22.088216Z","steps":["trace[163211283] 'process raft request' (duration: 96.633801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:23.501466Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553145770,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-02T08:46:23.512312Z","caller":"traceutil/trace.go:171","msg":"trace[420608822] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"660.946719ms","start":"2026-04-02T08:46:22.851334Z","end":"2026-04-02T08:46:23.512281Z","steps":["trace[420608822] 'process raft request' (duration: 660.750153ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:23.512526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:22.851303Z","time spent":"661.094884ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":13214,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:23.515525Z","caller":"traceutil/trace.go:171","msg":"trace[974049571] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"529.442661ms","start":"2026-04-02T08:46:22.986064Z","end":"2026-04-02T08:46:23.515507Z","steps":["trace[974049571] 'process raft request' (duration: 529.289806ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:23.515528Z","caller":"traceutil/trace.go:171","msg":"trace[1840459523] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:704; }","duration":"514.419085ms","start":"2026-04-02T08:46:23.001075Z","end":"2026-04-02T08:46:23.515494Z","steps":["trace[1840459523] 'read index received' (duration: 511.060177ms)","trace[1840459523] 'applied index is now lower than readState.Index' (duration: 3.358278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:46:23.515612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:22.986019Z","time spent":"529.547744ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T08:46:23.515603Z","caller":"traceutil/trace.go:171","msg":"trace[527693056] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"330.974486ms","start":"2026-04-02T08:46:23.184598Z","end":"2026-04-02T08:46:23.515572Z","steps":["trace[527693056] 'process raft request' (duration: 330.866012ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:23.515855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:23.184559Z","time spent":"331.176473ms","remote":"127.0.0.1:44916","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:46:23.516072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"514.967983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-dvbvw\" ","response":"range_response_count:1 size:4884"} {"level":"info","ts":"2026-04-02T08:46:23.516158Z","caller":"traceutil/trace.go:171","msg":"trace[824705908] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-dvbvw; range_end:; response_count:1; response_revision:680; }","duration":"515.106097ms","start":"2026-04-02T08:46:23.001038Z","end":"2026-04-02T08:46:23.516144Z","steps":["trace[824705908] 'agreement among raft nodes before linearized reading' (duration: 514.640692ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:23.516188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:23.001014Z","time spent":"515.167699ms","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4908,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-dvbvw\" "} {"level":"warn","ts":"2026-04-02T08:46:23.516972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.284326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:23.517112Z","caller":"traceutil/trace.go:171","msg":"trace[1423697251] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:680; }","duration":"133.487262ms","start":"2026-04-02T08:46:23.383607Z","end":"2026-04-02T08:46:23.517094Z","steps":["trace[1423697251] 'agreement among raft nodes before linearized reading' (duration: 133.294186ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:30.735922Z","caller":"traceutil/trace.go:171","msg":"trace[1129825524] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"123.661391ms","start":"2026-04-02T08:46:30.612233Z","end":"2026-04-02T08:46:30.735895Z","steps":["trace[1129825524] 'process raft request' (duration: 123.441153ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:31.736665Z","caller":"traceutil/trace.go:171","msg":"trace[803767504] linearizableReadLoop","detail":"{readStateIndex:796; appliedIndex:795; }","duration":"101.742317ms","start":"2026-04-02T08:46:31.634896Z","end":"2026-04-02T08:46:31.736638Z","steps":["trace[803767504] 'read index received' (duration: 42.263331ms)","trace[803767504] 'applied index is now lower than readState.Index' (duration: 59.477916ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:46:31.736677Z","caller":"traceutil/trace.go:171","msg":"trace[127249448] transaction","detail":"{read_only:false; response_revision:767; number_of_response:1; }","duration":"146.077156ms","start":"2026-04-02T08:46:31.590564Z","end":"2026-04-02T08:46:31.736641Z","steps":["trace[127249448] 'process raft request' (duration: 86.595759ms)","trace[127249448] 'compare' (duration: 59.27155ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:46:31.736916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.874898ms","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-02T08:46:31.736977Z","caller":"traceutil/trace.go:171","msg":"trace[1350926023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:768; }","duration":"165.95439ms","start":"2026-04-02T08:46:31.57101Z","end":"2026-04-02T08:46:31.736964Z","steps":["trace[1350926023] 'agreement among raft nodes before linearized reading' (duration: 165.756624ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:33.942268Z","caller":"traceutil/trace.go:171","msg":"trace[833837770] linearizableReadLoop","detail":"{readStateIndex:814; appliedIndex:813; }","duration":"303.038715ms","start":"2026-04-02T08:46:33.639201Z","end":"2026-04-02T08:46:33.94224Z","steps":["trace[833837770] 'read index received' (duration: 302.817758ms)","trace[833837770] 'applied index is now lower than readState.Index' (duration: 217.347µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:46:33.942436Z","caller":"traceutil/trace.go:171","msg":"trace[2070746641] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"356.582224ms","start":"2026-04-02T08:46:33.585819Z","end":"2026-04-02T08:46:33.942401Z","steps":["trace[2070746641] 'process raft request' (duration: 356.257413ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:33.942569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.340776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-02T08:46:33.942607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:33.585784Z","time spent":"356.734629ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:33.942619Z","caller":"traceutil/trace.go:171","msg":"trace[340952477] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:784; }","duration":"303.450739ms","start":"2026-04-02T08:46:33.639151Z","end":"2026-04-02T08:46:33.942602Z","steps":["trace[340952477] 'agreement among raft nodes before linearized reading' (duration: 303.260963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:33.942668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:33.639129Z","time spent":"303.527222ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T08:46:33.942837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.971563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:33.942908Z","caller":"traceutil/trace.go:171","msg":"trace[1864206655] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:784; }","duration":"243.107487ms","start":"2026-04-02T08:46:33.699784Z","end":"2026-04-02T08:46:33.942892Z","steps":["trace[1864206655] 'agreement among raft nodes before linearized reading' (duration: 242.961962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:33.943193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.864112ms","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-02T08:46:33.943661Z","caller":"traceutil/trace.go:171","msg":"trace[453611894] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:784; }","duration":"191.39776ms","start":"2026-04-02T08:46:33.75224Z","end":"2026-04-02T08:46:33.943638Z","steps":["trace[453611894] 'agreement among raft nodes before linearized reading' (duration: 190.529411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:33.943561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.33007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T08:46:33.943814Z","caller":"traceutil/trace.go:171","msg":"trace[348600166] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:784; }","duration":"202.6129ms","start":"2026-04-02T08:46:33.741182Z","end":"2026-04-02T08:46:33.943795Z","steps":["trace[348600166] 'agreement among raft nodes before linearized reading' (duration: 201.610857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:37.928198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xznml\" ","response":"range_response_count:1 size:3964"} {"level":"info","ts":"2026-04-02T08:46:37.928373Z","caller":"traceutil/trace.go:171","msg":"trace[1005105715] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-xznml; range_end:; response_count:1; response_revision:807; }","duration":"111.212948ms","start":"2026-04-02T08:46:37.817142Z","end":"2026-04-02T08:46:37.928355Z","steps":["trace[1005105715] 'range keys from in-memory index tree' (duration: 110.792344ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:38.455969Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553146035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:38.95684Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553146035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:39.4577Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553146035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:39.95829Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553146035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:40.459075Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553146035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:40.959536Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15036003261553146035,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-02T08:46:40.974839Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.957916447s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T08:46:40.975279Z","caller":"traceutil/trace.go:171","msg":"trace[819759416] transaction","detail":"{read_only:false; response_revision:808; number_of_response:1; }","duration":"3.038324761s","start":"2026-04-02T08:46:37.936926Z","end":"2026-04-02T08:46:40.975251Z","steps":["trace[819759416] 'process raft request' (duration: 3.038119865s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.975429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:37.936908Z","time spent":"3.038435196s","remote":"127.0.0.1:45036","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:46:40.986342Z","caller":"traceutil/trace.go:171","msg":"trace[1116174950] linearizableReadLoop","detail":"{readStateIndex:840; appliedIndex:838; }","duration":"3.030809594s","start":"2026-04-02T08:46:37.955515Z","end":"2026-04-02T08:46:40.986325Z","steps":["trace[1116174950] 'read index received' (duration: 3.019585308s)","trace[1116174950] 'applied index is now lower than readState.Index' (duration: 11.223246ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:46:40.986411Z","caller":"traceutil/trace.go:171","msg":"trace[1636565569] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"561.995627ms","start":"2026-04-02T08:46:40.424409Z","end":"2026-04-02T08:46:40.986405Z","steps":["trace[1636565569] 'process raft request' (duration: 561.808111ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.986479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:40.424388Z","time spent":"562.040479ms","remote":"127.0.0.1:45034","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5051,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:46:40.986662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.031153456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-02T08:46:40.986662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.286071023s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T08:46:40.986673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.015227496s","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-02T08:46:40.986701Z","caller":"traceutil/trace.go:171","msg":"trace[799927374] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:809; }","duration":"3.031229628s","start":"2026-04-02T08:46:37.955461Z","end":"2026-04-02T08:46:40.986691Z","steps":["trace[799927374] 'agreement among raft nodes before linearized reading' (duration: 3.031114014s)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:40.986708Z","caller":"traceutil/trace.go:171","msg":"trace[1454767815] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:809; }","duration":"1.286733365s","start":"2026-04-02T08:46:39.699964Z","end":"2026-04-02T08:46:40.986697Z","steps":["trace[1454767815] 'agreement among raft nodes before linearized reading' (duration: 1.286653072s)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:46:40.986726Z","caller":"traceutil/trace.go:171","msg":"trace[1588628960] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:809; }","duration":"3.015305228s","start":"2026-04-02T08:46:37.971401Z","end":"2026-04-02T08:46:40.986707Z","steps":["trace[1588628960] 'agreement among raft nodes before linearized reading' (duration: 3.015185084s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.986743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:39.699942Z","time spent":"1.286793847s","remote":"127.0.0.1:44836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-02T08:46:40.986751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:37.955435Z","time spent":"3.03129798s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T08:46:40.986837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.015204875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T08:46:40.986906Z","caller":"traceutil/trace.go:171","msg":"trace[4687559] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:809; }","duration":"3.015299229s","start":"2026-04-02T08:46:37.971596Z","end":"2026-04-02T08:46:40.986895Z","steps":["trace[4687559] 'agreement among raft nodes before linearized reading' (duration: 3.015140753s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.986944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:37.971583Z","time spent":"3.01535206s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T08:46:40.987085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.072208932s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-02T08:46:40.987122Z","caller":"traceutil/trace.go:171","msg":"trace[926360001] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:809; }","duration":"2.072283344s","start":"2026-04-02T08:46:38.91483Z","end":"2026-04-02T08:46:40.987114Z","steps":["trace[926360001] 'agreement among raft nodes before linearized reading' (duration: 2.072188951s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.987152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:38.9148Z","time spent":"2.072342236s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T08:46:40.987159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.015558187s","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-02T08:46:40.98759Z","caller":"traceutil/trace.go:171","msg":"trace[1387180606] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:809; }","duration":"3.015993541s","start":"2026-04-02T08:46:37.971577Z","end":"2026-04-02T08:46:40.98757Z","steps":["trace[1387180606] 'agreement among raft nodes before linearized reading' (duration: 3.015486474s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.988481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:37.971572Z","time spent":"3.01686631s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-02T08:46:40.986883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.118423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:46:40.988637Z","caller":"traceutil/trace.go:171","msg":"trace[1831274530] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:809; }","duration":"282.931703ms","start":"2026-04-02T08:46:40.705685Z","end":"2026-04-02T08:46:40.988617Z","steps":["trace[1831274530] 'agreement among raft nodes before linearized reading' (duration: 281.001079ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.987276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.450063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T08:46:40.988863Z","caller":"traceutil/trace.go:171","msg":"trace[736859387] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:809; }","duration":"147.997274ms","start":"2026-04-02T08:46:40.840772Z","end":"2026-04-02T08:46:40.98877Z","steps":["trace[736859387] 'agreement among raft nodes before linearized reading' (duration: 146.434142ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:46:40.986777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:46:37.971383Z","time spent":"3.015383071s","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T08:47:03.399619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.760986ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T08:47:03.399758Z","caller":"traceutil/trace.go:171","msg":"trace[445963197] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"202.659128ms","start":"2026-04-02T08:47:03.197063Z","end":"2026-04-02T08:47:03.399722Z","steps":["trace[445963197] 'process raft request' (duration: 41.702605ms)","trace[445963197] 'compare' (duration: 160.609091ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:47:03.442435Z","caller":"traceutil/trace.go:171","msg":"trace[1250346578] transaction","detail":"{read_only:false; response_revision:1011; number_of_response:1; }","duration":"243.783804ms","start":"2026-04-02T08:47:03.198027Z","end":"2026-04-02T08:47:03.441811Z","steps":["trace[1250346578] 'process raft request' (duration: 243.606438ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:47:25.486716Z","caller":"traceutil/trace.go:171","msg":"trace[610632300] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"133.167316ms","start":"2026-04-02T08:47:25.353506Z","end":"2026-04-02T08:47:25.486673Z","steps":["trace[610632300] 'process raft request' (duration: 86.690444ms)","trace[610632300] 'compare' (duration: 46.275845ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:47:27.008234Z","caller":"traceutil/trace.go:171","msg":"trace[581061039] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"233.335231ms","start":"2026-04-02T08:47:26.774873Z","end":"2026-04-02T08:47:27.008208Z","steps":["trace[581061039] 'process raft request' (duration: 143.95505ms)","trace[581061039] 'compare' (duration: 89.267837ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:47:27.238521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.755485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-02T08:47:27.238623Z","caller":"traceutil/trace.go:171","msg":"trace[1730257835] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1091; }","duration":"110.915351ms","start":"2026-04-02T08:47:27.127679Z","end":"2026-04-02T08:47:27.238594Z","steps":["trace[1730257835] 'count revisions from in-memory index tree' (duration: 110.668412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:47:27.607726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.220536ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T08:47:27.607861Z","caller":"traceutil/trace.go:171","msg":"trace[527929799] linearizableReadLoop","detail":"{readStateIndex:1137; appliedIndex:1136; }","duration":"115.605496ms","start":"2026-04-02T08:47:27.492238Z","end":"2026-04-02T08:47:27.607843Z","steps":["trace[527929799] 'read index received' (duration: 37.981µs)","trace[527929799] 'applied index is now lower than readState.Index' (duration: 115.566165ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:47:27.608047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.788702ms","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-02T08:47:27.60812Z","caller":"traceutil/trace.go:171","msg":"trace[623533537] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1093; }","duration":"115.917577ms","start":"2026-04-02T08:47:27.492185Z","end":"2026-04-02T08:47:27.608102Z","steps":["trace[623533537] 'agreement among raft nodes before linearized reading' (duration: 115.761961ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:47:27.608242Z","caller":"traceutil/trace.go:171","msg":"trace[1062996983] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"215.438417ms","start":"2026-04-02T08:47:27.392779Z","end":"2026-04-02T08:47:27.608218Z","steps":["trace[1062996983] 'process raft request' (duration: 52.619821ms)","trace[1062996983] 'compare' (duration: 162.08583ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:47:27.831044Z","caller":"traceutil/trace.go:171","msg":"trace[451152175] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"216.620579ms","start":"2026-04-02T08:47:27.614398Z","end":"2026-04-02T08:47:27.831019Z","steps":["trace[451152175] 'process raft request' (duration: 128.352495ms)","trace[451152175] 'compare' (duration: 88.167671ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:47:27.913115Z","caller":"traceutil/trace.go:171","msg":"trace[512526676] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"296.54881ms","start":"2026-04-02T08:47:27.616542Z","end":"2026-04-02T08:47:27.913091Z","steps":["trace[512526676] 'process raft request' (duration: 296.518489ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:47:27.913418Z","caller":"traceutil/trace.go:171","msg":"trace[919466395] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"298.729797ms","start":"2026-04-02T08:47:27.614681Z","end":"2026-04-02T08:47:27.913411Z","steps":["trace[919466395] 'process raft request' (duration: 298.287411ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:47:46.003358Z","caller":"traceutil/trace.go:171","msg":"trace[1501955481] transaction","detail":"{read_only:false; response_revision:1151; number_of_response:1; }","duration":"131.225907ms","start":"2026-04-02T08:47:45.872103Z","end":"2026-04-02T08:47:46.003329Z","steps":["trace[1501955481] 'process raft request' (duration: 131.066511ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:47:48.492403Z","caller":"traceutil/trace.go:171","msg":"trace[2032179592] transaction","detail":"{read_only:false; response_revision:1163; number_of_response:1; }","duration":"131.315788ms","start":"2026-04-02T08:47:48.361059Z","end":"2026-04-02T08:47:48.492375Z","steps":["trace[2032179592] 'process raft request' (duration: 131.118611ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:47:50.314721Z","caller":"traceutil/trace.go:171","msg":"trace[1037304801] linearizableReadLoop","detail":"{readStateIndex:1215; appliedIndex:1214; }","duration":"133.452798ms","start":"2026-04-02T08:47:50.181237Z","end":"2026-04-02T08:47:50.31469Z","steps":["trace[1037304801] 'read index received' (duration: 100.844715ms)","trace[1037304801] 'applied index is now lower than readState.Index' (duration: 32.606913ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:47:50.314928Z","caller":"traceutil/trace.go:171","msg":"trace[1057158902] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"168.776748ms","start":"2026-04-02T08:47:50.146106Z","end":"2026-04-02T08:47:50.314882Z","steps":["trace[1057158902] 'process raft request' (duration: 135.965368ms)","trace[1057158902] 'compare' (duration: 32.476688ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:47:50.31498Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.717738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T08:47:50.315021Z","caller":"traceutil/trace.go:171","msg":"trace[2137923570] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1167; }","duration":"133.824221ms","start":"2026-04-02T08:47:50.181184Z","end":"2026-04-02T08:47:50.315008Z","steps":["trace[2137923570] 'agreement among raft nodes before linearized reading' (duration: 133.641535ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:48:08.501217Z","caller":"traceutil/trace.go:171","msg":"trace[663984501] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"127.454379ms","start":"2026-04-02T08:48:08.373747Z","end":"2026-04-02T08:48:08.501201Z","steps":["trace[663984501] 'process raft request' (duration: 124.97511ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:48:32.109387Z","caller":"traceutil/trace.go:171","msg":"trace[32063197] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"108.609442ms","start":"2026-04-02T08:48:32.00073Z","end":"2026-04-02T08:48:32.109339Z","steps":["trace[32063197] 'process raft request' (duration: 108.353722ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:32.605787Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.376134ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-02T08:48:32.606038Z","caller":"traceutil/trace.go:171","msg":"trace[488544819] linearizableReadLoop","detail":"{readStateIndex:1392; appliedIndex:1391; }","duration":"137.911082ms","start":"2026-04-02T08:48:32.4681Z","end":"2026-04-02T08:48:32.606011Z","steps":["trace[488544819] 'read index received' (duration: 64.373µs)","trace[488544819] 'applied index is now lower than readState.Index' (duration: 137.844469ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:48:32.606246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.114089ms","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:7"} {"level":"info","ts":"2026-04-02T08:48:32.606433Z","caller":"traceutil/trace.go:171","msg":"trace[1931192324] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1334; }","duration":"138.360928ms","start":"2026-04-02T08:48:32.468042Z","end":"2026-04-02T08:48:32.606403Z","steps":["trace[1931192324] 'agreement among raft nodes before linearized reading' (duration: 138.071188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:32.606284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.262949ms","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-02T08:48:32.606651Z","caller":"traceutil/trace.go:171","msg":"trace[1630603289] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1334; }","duration":"129.666754ms","start":"2026-04-02T08:48:32.476968Z","end":"2026-04-02T08:48:32.606635Z","steps":["trace[1630603289] 'agreement among raft nodes before linearized reading' (duration: 129.165376ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:48:32.983439Z","caller":"traceutil/trace.go:171","msg":"trace[1643550194] transaction","detail":"{read_only:false; response_revision:1339; number_of_response:1; }","duration":"139.673336ms","start":"2026-04-02T08:48:32.843737Z","end":"2026-04-02T08:48:32.98341Z","steps":["trace[1643550194] 'process raft request' (duration: 130.525004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.364752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.28896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-02T08:48:41.364971Z","caller":"traceutil/trace.go:171","msg":"trace[792417226] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"502.805588ms","start":"2026-04-02T08:48:40.862147Z","end":"2026-04-02T08:48:41.364948Z","steps":["trace[792417226] 'process raft request' (duration: 502.734136ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:48:41.364991Z","caller":"traceutil/trace.go:171","msg":"trace[329152868] linearizableReadLoop","detail":"{readStateIndex:1426; appliedIndex:1425; }","duration":"693.077128ms","start":"2026-04-02T08:48:40.671886Z","end":"2026-04-02T08:48:41.364963Z","steps":["trace[329152868] 'read index received' (duration: 44.701µs)","trace[329152868] 'applied index is now lower than readState.Index' (duration: 693.029707ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:48:41.365043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:40.862119Z","time spent":"502.890062ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:48:41.365112Z","caller":"traceutil/trace.go:171","msg":"trace[1007447207] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"856.026278ms","start":"2026-04-02T08:48:40.509076Z","end":"2026-04-02T08:48:41.365102Z","steps":["trace[1007447207] 'process raft request' (duration: 155.316263ms)","trace[1007447207] 'compare' (duration: 700.176576ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:48:41.365181Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:40.509058Z","time spent":"856.07855ms","remote":"127.0.0.1:44932","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":706,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T08:48:41.365294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"693.408301ms","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-02T08:48:41.365322Z","caller":"traceutil/trace.go:171","msg":"trace[212302791] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1368; }","duration":"693.491854ms","start":"2026-04-02T08:48:40.671823Z","end":"2026-04-02T08:48:41.365314Z","steps":["trace[212302791] 'agreement among raft nodes before linearized reading' (duration: 693.40514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.36534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:40.6718Z","time spent":"693.535314ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-02T08:48:41.365302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.239802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-02T08:48:41.365441Z","caller":"traceutil/trace.go:171","msg":"trace[639156235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1368; }","duration":"688.403959ms","start":"2026-04-02T08:48:40.677024Z","end":"2026-04-02T08:48:41.365428Z","steps":["trace[639156235] 'agreement among raft nodes before linearized reading' (duration: 688.094527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.365509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:40.677013Z","time spent":"688.484731ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T08:48:41.36557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.580599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-04-02T08:48:41.365633Z","caller":"traceutil/trace.go:171","msg":"trace[346232902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1368; }","duration":"328.680414ms","start":"2026-04-02T08:48:41.036937Z","end":"2026-04-02T08:48:41.365618Z","steps":["trace[346232902] 'agreement among raft nodes before linearized reading' (duration: 328.556489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.365744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:41.036915Z","time spent":"328.816599ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-02T08:48:41.365589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.719542ms","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-02T08:48:41.365938Z","caller":"traceutil/trace.go:171","msg":"trace[1152318872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1368; }","duration":"675.098476ms","start":"2026-04-02T08:48:40.690828Z","end":"2026-04-02T08:48:41.365926Z","steps":["trace[1152318872] 'agreement among raft nodes before linearized reading' (duration: 674.702961ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.36598Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:40.690811Z","time spent":"675.158538ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T08:48:41.836204Z","caller":"traceutil/trace.go:171","msg":"trace[62749821] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"464.918945ms","start":"2026-04-02T08:48:41.371242Z","end":"2026-04-02T08:48:41.836161Z","steps":["trace[62749821] 'process raft request' (duration: 464.613604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.836355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:41.371223Z","time spent":"465.05273ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:48:41.836384Z","caller":"traceutil/trace.go:171","msg":"trace[1990284606] linearizableReadLoop","detail":"{readStateIndex:1431; appliedIndex:1428; }","duration":"135.314329ms","start":"2026-04-02T08:48:41.701049Z","end":"2026-04-02T08:48:41.836363Z","steps":["trace[1990284606] 'read index received' (duration: 134.871263ms)","trace[1990284606] 'applied index is now lower than readState.Index' (duration: 441.986µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T08:48:41.836513Z","caller":"traceutil/trace.go:171","msg":"trace[648460471] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"464.730388ms","start":"2026-04-02T08:48:41.371772Z","end":"2026-04-02T08:48:41.836502Z","steps":["trace[648460471] 'process raft request' (duration: 464.343604ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.836587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:41.371766Z","time spent":"464.791571ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:48:41.836658Z","caller":"traceutil/trace.go:171","msg":"trace[976934119] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"463.708441ms","start":"2026-04-02T08:48:41.372857Z","end":"2026-04-02T08:48:41.836565Z","steps":["trace[976934119] 'process raft request' (duration: 463.451202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:41.836756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:41.372852Z","time spent":"463.850216ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T08:48:41.836796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.728034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T08:48:41.836868Z","caller":"traceutil/trace.go:171","msg":"trace[441870135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1372; }","duration":"135.847197ms","start":"2026-04-02T08:48:41.701001Z","end":"2026-04-02T08:48:41.836848Z","steps":["trace[441870135] 'agreement among raft nodes before linearized reading' (duration: 135.734393ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:48:42.639153Z","caller":"traceutil/trace.go:171","msg":"trace[2005682072] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"407.967722ms","start":"2026-04-02T08:48:42.231156Z","end":"2026-04-02T08:48:42.639124Z","steps":["trace[2005682072] 'process raft request' (duration: 407.770525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:48:42.639541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T08:48:42.231138Z","time spent":"408.116498ms","remote":"127.0.0.1:45116","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T08:49:10.293356Z","caller":"traceutil/trace.go:171","msg":"trace[2017385292] transaction","detail":"{read_only:false; response_revision:1469; number_of_response:1; }","duration":"232.298519ms","start":"2026-04-02T08:49:10.06104Z","end":"2026-04-02T08:49:10.293339Z","steps":["trace[2017385292] 'process raft request' (duration: 232.148883ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:49:10.321203Z","caller":"traceutil/trace.go:171","msg":"trace[662580698] linearizableReadLoop","detail":"{readStateIndex:1535; appliedIndex:1533; }","duration":"255.243146ms","start":"2026-04-02T08:49:10.065925Z","end":"2026-04-02T08:49:10.321168Z","steps":["trace[662580698] 'read index received' (duration: 227.267976ms)","trace[662580698] 'applied index is now lower than readState.Index' (duration: 27.97424ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T08:49:10.321361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.422642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/default\" ","response":"range_response_count:1 size:179"} {"level":"info","ts":"2026-04-02T08:49:10.321404Z","caller":"traceutil/trace.go:171","msg":"trace[900995988] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/default; range_end:; response_count:1; response_revision:1470; }","duration":"255.512156ms","start":"2026-04-02T08:49:10.065881Z","end":"2026-04-02T08:49:10.321393Z","steps":["trace[900995988] 'agreement among raft nodes before linearized reading' (duration: 255.416622ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T08:49:10.321384Z","caller":"traceutil/trace.go:171","msg":"trace[1594754832] transaction","detail":"{read_only:false; response_revision:1470; number_of_response:1; }","duration":"259.334695ms","start":"2026-04-02T08:49:10.061999Z","end":"2026-04-02T08:49:10.321334Z","steps":["trace[1594754832] 'process raft request' (duration: 259.069326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T08:49:10.321502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.691641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/kubeadm-certs\" ","response":"range_response_count:1 size:11451"} {"level":"info","ts":"2026-04-02T08:49:10.321556Z","caller":"traceutil/trace.go:171","msg":"trace[2082492923] range","detail":"{range_begin:/registry/secrets/kube-system/kubeadm-certs; range_end:; response_count:1; response_revision:1470; }","duration":"182.793304ms","start":"2026-04-02T08:49:10.13875Z","end":"2026-04-02T08:49:10.321543Z","steps":["trace[2082492923] 'agreement among raft nodes before linearized reading' (duration: 182.664249ms)"],"step_count":1}