{"level":"warn","ts":"2026-04-02T22:25:55.492117Z","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-02T22:25:55.492257Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.222: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.222:2380","--initial-cluster=instance=https://199.204.45.222:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.222:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.222: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-02T22:25:55.492354Z","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-02T22:25:55.492371Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-04-02T22:25:55.492395Z","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-02T22:25:55.493323Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"]} {"level":"info","ts":"2026-04-02T22:25:55.493416Z","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.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.222: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-02T22:25:55.49894Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.248569ms"} {"level":"info","ts":"2026-04-02T22:25:55.506788Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"380f6760faea5f9e","cluster-id":"b87e8aca83a17eab"} {"level":"info","ts":"2026-04-02T22:25:55.507168Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=()"} {"level":"info","ts":"2026-04-02T22:25:55.507201Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 0"} {"level":"info","ts":"2026-04-02T22:25:55.507219Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 380f6760faea5f9e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-02T22:25:55.507233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became follower at term 1"} {"level":"info","ts":"2026-04-02T22:25:55.507283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"warn","ts":"2026-04-02T22:25:55.513979Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-02T22:25:55.515641Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-02T22:25:55.517038Z","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-02T22:25:55.519027Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"380f6760faea5f9e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-02T22:25:55.519159Z","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-02T22:25:55.519276Z","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-02T22:25:55.519292Z","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-02T22:25:55.519861Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"380f6760faea5f9e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-02T22:25:55.520834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e switched to configuration voters=(4039561056998809502)"} {"level":"info","ts":"2026-04-02T22:25:55.52432Z","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-02T22:25:55.524509Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-04-02T22:25:55.524551Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.222:2380"} {"level":"info","ts":"2026-04-02T22:25:55.524891Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-02T22:25:55.52474Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"380f6760faea5f9e","initial-advertise-peer-urls":["https://199.204.45.222:2380"],"listen-peer-urls":["https://199.204.45.222:2380"],"advertise-client-urls":["https://199.204.45.222:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.222:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-02T22:25:55.525828Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","added-peer-id":"380f6760faea5f9e","added-peer-peer-urls":["https://199.204.45.222:2380"]} {"level":"info","ts":"2026-04-02T22:25:56.307968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e is starting a new election at term 1"} {"level":"info","ts":"2026-04-02T22:25:56.308017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became pre-candidate at term 1"} {"level":"info","ts":"2026-04-02T22:25:56.308055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgPreVoteResp from 380f6760faea5f9e at term 1"} {"level":"info","ts":"2026-04-02T22:25:56.308069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became candidate at term 2"} {"level":"info","ts":"2026-04-02T22:25:56.308078Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e received MsgVoteResp from 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-04-02T22:25:56.308086Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"380f6760faea5f9e became leader at term 2"} {"level":"info","ts":"2026-04-02T22:25:56.308093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 380f6760faea5f9e elected leader 380f6760faea5f9e at term 2"} {"level":"info","ts":"2026-04-02T22:25:56.393147Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"380f6760faea5f9e","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.222:2379]}","request-path":"/0/members/380f6760faea5f9e/attributes","cluster-id":"b87e8aca83a17eab","publish-timeout":"7s"} {"level":"info","ts":"2026-04-02T22:25:56.393237Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:25:56.393672Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:25:56.393971Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-02T22:25:56.397742Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-02T22:25:56.397778Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b87e8aca83a17eab","local-member-id":"380f6760faea5f9e","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:25:56.397914Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:25:56.397975Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-02T22:25:56.40294Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.222:2379"} {"level":"info","ts":"2026-04-02T22:25:56.408289Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-02T22:25:56.408353Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-02T22:26:14.397866Z","caller":"traceutil/trace.go:171","msg":"trace[844775868] linearizableReadLoop","detail":"{readStateIndex:428; appliedIndex:427; }","duration":"480.92104ms","start":"2026-04-02T22:26:13.916918Z","end":"2026-04-02T22:26:14.397839Z","steps":["trace[844775868] 'read index received' (duration: 480.739149ms)","trace[844775868] 'applied index is now lower than readState.Index' (duration: 180.661µs)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:14.397963Z","caller":"traceutil/trace.go:171","msg":"trace[1063405424] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"483.452868ms","start":"2026-04-02T22:26:13.914479Z","end":"2026-04-02T22:26:14.397932Z","steps":["trace[1063405424] 'process raft request' (duration: 483.159207ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:14.398073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.08888ms","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-02T22:26:14.398073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.122061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T22:26:14.398158Z","caller":"traceutil/trace.go:171","msg":"trace[301553796] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:418; }","duration":"481.220421ms","start":"2026-04-02T22:26:13.916926Z","end":"2026-04-02T22:26:14.398147Z","steps":["trace[301553796] 'agreement among raft nodes before linearized reading' (duration: 481.09566ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:14.398155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.842019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4376"} {"level":"info","ts":"2026-04-02T22:26:14.39818Z","caller":"traceutil/trace.go:171","msg":"trace[666126046] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:418; }","duration":"481.262932ms","start":"2026-04-02T22:26:13.916898Z","end":"2026-04-02T22:26:14.398161Z","steps":["trace[666126046] 'agreement among raft nodes before linearized reading' (duration: 481.076191ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:14.398276Z","caller":"traceutil/trace.go:171","msg":"trace[906515265] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:418; }","duration":"202.956409ms","start":"2026-04-02T22:26:14.195284Z","end":"2026-04-02T22:26:14.398241Z","steps":["trace[906515265] 'agreement among raft nodes before linearized reading' (duration: 202.782478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:14.398281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:13.916889Z","time spent":"481.383062ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T22:26:14.398206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:13.916908Z","time spent":"481.280792ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T22:26:14.399062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:13.914452Z","time spent":"483.582218ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:26:26.911692Z","caller":"traceutil/trace.go:171","msg":"trace[166301232] linearizableReadLoop","detail":"{readStateIndex:488; appliedIndex:487; }","duration":"153.943021ms","start":"2026-04-02T22:26:26.757725Z","end":"2026-04-02T22:26:26.911668Z","steps":["trace[166301232] 'read index received' (duration: 153.896349ms)","trace[166301232] 'applied index is now lower than readState.Index' (duration: 45.322µs)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:26:26.911934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.17432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T22:26:26.912043Z","caller":"traceutil/trace.go:171","msg":"trace[690604600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:474; }","duration":"154.333466ms","start":"2026-04-02T22:26:26.757687Z","end":"2026-04-02T22:26:26.91202Z","steps":["trace[690604600] 'agreement among raft nodes before linearized reading' (duration: 154.109777ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:26.912426Z","caller":"traceutil/trace.go:171","msg":"trace[2134644269] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"156.141668ms","start":"2026-04-02T22:26:26.756239Z","end":"2026-04-02T22:26:26.912381Z","steps":["trace[2134644269] 'process raft request' (duration: 155.298994ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:27.414185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.16004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:26:27.414339Z","caller":"traceutil/trace.go:171","msg":"trace[711088339] linearizableReadLoop","detail":"{readStateIndex:489; appliedIndex:488; }","duration":"502.509567ms","start":"2026-04-02T22:26:26.911765Z","end":"2026-04-02T22:26:27.414274Z","steps":["trace[711088339] 'read index received' (duration: 128.876347ms)","trace[711088339] 'applied index is now lower than readState.Index' (duration: 373.63203ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:27.41433Z","caller":"traceutil/trace.go:171","msg":"trace[1761277309] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"654.651806ms","start":"2026-04-02T22:26:26.759651Z","end":"2026-04-02T22:26:27.414303Z","steps":["trace[1761277309] 'process raft request' (duration: 281.051387ms)","trace[1761277309] 'compare' (duration: 373.052476ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:26:27.414609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"601.424599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:3 size:12669"} {"level":"warn","ts":"2026-04-02T22:26:27.414755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:26.759642Z","time spent":"654.980718ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:26:27.414787Z","caller":"traceutil/trace.go:171","msg":"trace[486458038] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:3; response_revision:475; }","duration":"601.613826ms","start":"2026-04-02T22:26:26.813111Z","end":"2026-04-02T22:26:27.414725Z","steps":["trace[486458038] 'agreement among raft nodes before linearized reading' (duration: 601.236851ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:27.414933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:26.813082Z","time spent":"601.830774ms","remote":"127.0.0.1:33698","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":3,"response size":12692,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-04-02T22:26:27.41455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"656.360894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T22:26:27.41513Z","caller":"traceutil/trace.go:171","msg":"trace[1890252023] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:475; }","duration":"656.953097ms","start":"2026-04-02T22:26:26.758124Z","end":"2026-04-02T22:26:27.415077Z","steps":["trace[1890252023] 'agreement among raft nodes before linearized reading' (duration: 656.308862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:27.415254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:26.75811Z","time spent":"657.099793ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T22:26:27.42362Z","caller":"traceutil/trace.go:171","msg":"trace[325911715] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"507.303514ms","start":"2026-04-02T22:26:26.916301Z","end":"2026-04-02T22:26:27.423605Z","steps":["trace[325911715] 'process raft request' (duration: 507.004102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:27.423706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:26.916272Z","time spent":"507.391467ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:26:28.884378Z","caller":"traceutil/trace.go:171","msg":"trace[1415334597] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"118.405233ms","start":"2026-04-02T22:26:28.765941Z","end":"2026-04-02T22:26:28.884346Z","steps":["trace[1415334597] 'process raft request' (duration: 31.129208ms)","trace[1415334597] 'compare' (duration: 87.006435ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:30.511735Z","caller":"traceutil/trace.go:171","msg":"trace[465537032] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"662.557ms","start":"2026-04-02T22:26:29.849163Z","end":"2026-04-02T22:26:30.51172Z","steps":["trace[465537032] 'process raft request' (duration: 662.445696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.511834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.849146Z","time spent":"662.644113ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:26:30.536239Z","caller":"traceutil/trace.go:171","msg":"trace[1514409926] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"670.529316ms","start":"2026-04-02T22:26:29.865675Z","end":"2026-04-02T22:26:30.536204Z","steps":["trace[1514409926] 'process raft request' (duration: 670.181733ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:30.536331Z","caller":"traceutil/trace.go:171","msg":"trace[1735382823] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"685.377319ms","start":"2026-04-02T22:26:29.850917Z","end":"2026-04-02T22:26:30.536294Z","steps":["trace[1735382823] 'process raft request' (duration: 684.897661ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:30.536335Z","caller":"traceutil/trace.go:171","msg":"trace[1732600014] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"685.431022ms","start":"2026-04-02T22:26:29.850849Z","end":"2026-04-02T22:26:30.53628Z","steps":["trace[1732600014] 'process raft request' (duration: 684.84956ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.536403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.865654Z","time spent":"670.679452ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:26:30.536422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.850912Z","time spent":"685.469052ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:26:30.536524Z","caller":"traceutil/trace.go:171","msg":"trace[2054476076] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"658.948458ms","start":"2026-04-02T22:26:29.877565Z","end":"2026-04-02T22:26:30.536514Z","steps":["trace[2054476076] 'process raft request' (duration: 658.515062ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:30.536553Z","caller":"traceutil/trace.go:171","msg":"trace[1121491942] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"650.887326ms","start":"2026-04-02T22:26:29.885655Z","end":"2026-04-02T22:26:30.536542Z","steps":["trace[1121491942] 'process raft request' (duration: 650.516472ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.536552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.850829Z","time spent":"685.612749ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:26:30.536578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.877561Z","time spent":"658.99605ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:26:30.5366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.885634Z","time spent":"650.943829ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:26:30.536663Z","caller":"traceutil/trace.go:171","msg":"trace[1249027506] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"670.85987ms","start":"2026-04-02T22:26:29.865795Z","end":"2026-04-02T22:26:30.536654Z","steps":["trace[1249027506] 'process raft request' (duration: 670.209384ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:30.536674Z","caller":"traceutil/trace.go:171","msg":"trace[1570475102] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"655.235915ms","start":"2026-04-02T22:26:29.88143Z","end":"2026-04-02T22:26:30.536666Z","steps":["trace[1570475102] 'process raft request' (duration: 654.684733ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.536703Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.865758Z","time spent":"670.926832ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:26:30.536729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.881424Z","time spent":"655.286147ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:26:30.53672Z","caller":"traceutil/trace.go:171","msg":"trace[249653889] linearizableReadLoop","detail":"{readStateIndex:544; appliedIndex:533; }","duration":"131.982185ms","start":"2026-04-02T22:26:30.404706Z","end":"2026-04-02T22:26:30.536688Z","steps":["trace[249653889] 'read index received' (duration: 107.097935ms)","trace[249653889] 'applied index is now lower than readState.Index' (duration: 24.8823ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:30.536768Z","caller":"traceutil/trace.go:171","msg":"trace[1437927966] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"613.888678ms","start":"2026-04-02T22:26:29.922853Z","end":"2026-04-02T22:26:30.536741Z","steps":["trace[1437927966] 'process raft request' (duration: 613.455081ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:30.536819Z","caller":"traceutil/trace.go:171","msg":"trace[108659348] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"523.79709ms","start":"2026-04-02T22:26:30.013Z","end":"2026-04-02T22:26:30.536797Z","steps":["trace[108659348] 'process raft request' (duration: 523.491727ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.536872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.922831Z","time spent":"614.002422ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:26:30.536827Z","caller":"traceutil/trace.go:171","msg":"trace[626708311] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"659.234429ms","start":"2026-04-02T22:26:29.877492Z","end":"2026-04-02T22:26:30.536726Z","steps":["trace[626708311] 'process raft request' (duration: 658.552753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.536918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:30.01297Z","time spent":"523.914135ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:26:30.536783Z","caller":"traceutil/trace.go:171","msg":"trace[394131618] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"639.216226ms","start":"2026-04-02T22:26:29.897559Z","end":"2026-04-02T22:26:30.536775Z","steps":["trace[394131618] 'process raft request' (duration: 638.696556ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.537083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.877477Z","time spent":"659.491959ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:26:30.536935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.185263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-02T22:26:30.537169Z","caller":"traceutil/trace.go:171","msg":"trace[865940537] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:529; }","duration":"132.498454ms","start":"2026-04-02T22:26:30.404651Z","end":"2026-04-02T22:26:30.53715Z","steps":["trace[865940537] 'agreement among raft nodes before linearized reading' (duration: 132.13115ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:30.537665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:29.897534Z","time spent":"639.483306ms","remote":"127.0.0.1:33656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-02T22:26:33.384356Z","caller":"traceutil/trace.go:171","msg":"trace[959530366] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"369.28991ms","start":"2026-04-02T22:26:33.015015Z","end":"2026-04-02T22:26:33.384305Z","steps":["trace[959530366] 'process raft request' (duration: 368.196911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:33.384607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:33.014985Z","time spent":"369.498998ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:26:37.40076Z","caller":"traceutil/trace.go:171","msg":"trace[2136161370] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"379.910958ms","start":"2026-04-02T22:26:37.020804Z","end":"2026-04-02T22:26:37.400715Z","steps":["trace[2136161370] 'process raft request' (duration: 379.610987ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:37.40092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:37.020786Z","time spent":"380.058293ms","remote":"127.0.0.1:34102","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-02T22:26:38.682782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191606575s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:26:38.682902Z","caller":"traceutil/trace.go:171","msg":"trace[569677994] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:646; }","duration":"1.198096472s","start":"2026-04-02T22:26:37.484785Z","end":"2026-04-02T22:26:38.682882Z","steps":["trace[569677994] 'read index received' (duration: 6.201316ms)","trace[569677994] 'applied index is now lower than readState.Index' (duration: 1.191893595s)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:38.683287Z","caller":"traceutil/trace.go:171","msg":"trace[959554947] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.26477948s","start":"2026-04-02T22:26:37.41845Z","end":"2026-04-02T22:26:38.683229Z","steps":["trace[959554947] 'process raft request' (duration: 72.608516ms)","trace[959554947] 'compare' (duration: 1.190987933s)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:26:38.683522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:37.418423Z","time spent":"1.264973166s","remote":"127.0.0.1:33800","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:26:38.683564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.198775444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-02T22:26:38.683603Z","caller":"traceutil/trace.go:171","msg":"trace[1733549144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:626; }","duration":"1.198848377s","start":"2026-04-02T22:26:37.484743Z","end":"2026-04-02T22:26:38.683591Z","steps":["trace[1733549144] 'agreement among raft nodes before linearized reading' (duration: 1.198603639s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:38.68382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:37.484718Z","time spent":"1.199002232s","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-02T22:26:38.890658Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.065982357s","expected-duration":"1s"} {"level":"info","ts":"2026-04-02T22:26:38.891758Z","caller":"traceutil/trace.go:171","msg":"trace[1966467823] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.068589748s","start":"2026-04-02T22:26:37.823141Z","end":"2026-04-02T22:26:38.891731Z","steps":["trace[1966467823] 'process raft request' (duration: 1.068007138s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:38.89195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:37.823111Z","time spent":"1.068748234s","remote":"127.0.0.1:33698","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-02T22:26:38.896532Z","caller":"traceutil/trace.go:171","msg":"trace[588083340] linearizableReadLoop","detail":"{readStateIndex:649; appliedIndex:647; }","duration":"213.394831ms","start":"2026-04-02T22:26:38.683113Z","end":"2026-04-02T22:26:38.896508Z","steps":["trace[588083340] 'read index received' (duration: 207.833539ms)","trace[588083340] 'applied index is now lower than readState.Index' (duration: 5.560282ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:38.89657Z","caller":"traceutil/trace.go:171","msg":"trace[857818602] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"206.697999ms","start":"2026-04-02T22:26:38.689844Z","end":"2026-04-02T22:26:38.896542Z","steps":["trace[857818602] 'process raft request' (duration: 206.608876ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:38.896696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.973285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-02T22:26:38.896744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.411676058s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T22:26:38.896788Z","caller":"traceutil/trace.go:171","msg":"trace[1306656004] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:629; }","duration":"1.41173866s","start":"2026-04-02T22:26:37.485039Z","end":"2026-04-02T22:26:38.896777Z","steps":["trace[1306656004] 'agreement among raft nodes before linearized reading' (duration: 1.411569694s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:38.896832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:37.48503Z","time spent":"1.411793012s","remote":"127.0.0.1:33856","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":"info","ts":"2026-04-02T22:26:38.896829Z","caller":"traceutil/trace.go:171","msg":"trace[778011259] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"216.715165ms","start":"2026-04-02T22:26:38.680068Z","end":"2026-04-02T22:26:38.896784Z","steps":["trace[778011259] 'process raft request' (duration: 216.246179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:38.896842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.408908081s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T22:26:38.896839Z","caller":"traceutil/trace.go:171","msg":"trace[1635927270] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"493.187592ms","start":"2026-04-02T22:26:38.403581Z","end":"2026-04-02T22:26:38.896769Z","steps":["trace[1635927270] 'agreement among raft nodes before linearized reading' (duration: 492.979085ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:38.896921Z","caller":"traceutil/trace.go:171","msg":"trace[1008759044] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:629; }","duration":"1.409027255s","start":"2026-04-02T22:26:37.487878Z","end":"2026-04-02T22:26:38.896905Z","steps":["trace[1008759044] 'agreement among raft nodes before linearized reading' (duration: 1.408845969s)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:38.896973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:37.48786Z","time spent":"1.409106199s","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-02T22:26:38.897319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:38.40356Z","time spent":"493.39547ms","remote":"127.0.0.1:33584","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-02T22:26:40.703248Z","caller":"traceutil/trace.go:171","msg":"trace[1042017961] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"252.314261ms","start":"2026-04-02T22:26:40.450906Z","end":"2026-04-02T22:26:40.703221Z","steps":["trace[1042017961] 'process raft request' (duration: 252.116334ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:40.831Z","caller":"traceutil/trace.go:171","msg":"trace[2049423369] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"246.885519ms","start":"2026-04-02T22:26:40.58409Z","end":"2026-04-02T22:26:40.830975Z","steps":["trace[2049423369] 'process raft request' (duration: 246.667941ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:40.83102Z","caller":"traceutil/trace.go:171","msg":"trace[268373430] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"236.185398ms","start":"2026-04-02T22:26:40.594806Z","end":"2026-04-02T22:26:40.830992Z","steps":["trace[268373430] 'process raft request' (duration: 236.122796ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:26:52.360505Z","caller":"traceutil/trace.go:171","msg":"trace[562231837] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"112.634168ms","start":"2026-04-02T22:26:52.247841Z","end":"2026-04-02T22:26:52.360475Z","steps":["trace[562231837] 'process raft request' (duration: 112.385901ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:55.470392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.622807ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-02T22:26:55.470918Z","caller":"traceutil/trace.go:171","msg":"trace[527838110] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"986.035193ms","start":"2026-04-02T22:26:54.484853Z","end":"2026-04-02T22:26:55.470888Z","steps":["trace[527838110] 'read index received' (duration: 258.800928ms)","trace[527838110] 'applied index is now lower than readState.Index' (duration: 727.231015ms)"],"step_count":2} {"level":"info","ts":"2026-04-02T22:26:55.471217Z","caller":"traceutil/trace.go:171","msg":"trace[583928739] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"1.101672131s","start":"2026-04-02T22:26:54.369007Z","end":"2026-04-02T22:26:55.470679Z","steps":["trace[583928739] 'process raft request' (duration: 374.698764ms)","trace[583928739] 'compare' (duration: 726.522104ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:26:55.471443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:54.368979Z","time spent":"1.10235253s","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-02T22:26:55.475938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.355276ms","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-02T22:26:55.476106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.352474ms","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-02T22:26:55.476147Z","caller":"traceutil/trace.go:171","msg":"trace[631236150] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:790; }","duration":"441.420946ms","start":"2026-04-02T22:26:55.034715Z","end":"2026-04-02T22:26:55.476136Z","steps":["trace[631236150] 'agreement among raft nodes before linearized reading' (duration: 441.322172ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:55.476175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:55.034694Z","time spent":"441.474728ms","remote":"127.0.0.1:33856","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-02T22:26:55.476095Z","caller":"traceutil/trace.go:171","msg":"trace[1293707883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:790; }","duration":"491.540421ms","start":"2026-04-02T22:26:54.984531Z","end":"2026-04-02T22:26:55.476072Z","steps":["trace[1293707883] 'agreement among raft nodes before linearized reading' (duration: 491.303865ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:55.476008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"991.150646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9b2p9\" ","response":"range_response_count:1 size:3965"} {"level":"warn","ts":"2026-04-02T22:26:55.476671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:54.984515Z","time spent":"491.967023ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-02T22:26:55.476741Z","caller":"traceutil/trace.go:171","msg":"trace[2042517267] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9b2p9; range_end:; response_count:1; response_revision:790; }","duration":"991.911719ms","start":"2026-04-02T22:26:54.484794Z","end":"2026-04-02T22:26:55.476706Z","steps":["trace[2042517267] 'agreement among raft nodes before linearized reading' (duration: 986.343202ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:55.477636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:54.48476Z","time spent":"992.854295ms","remote":"127.0.0.1:33800","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-9b2p9\" "} {"level":"warn","ts":"2026-04-02T22:26:55.476353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.371272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-04-02T22:26:55.477756Z","caller":"traceutil/trace.go:171","msg":"trace[2124412585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:790; }","duration":"443.781132ms","start":"2026-04-02T22:26:55.033934Z","end":"2026-04-02T22:26:55.477715Z","steps":["trace[2124412585] 'agreement among raft nodes before linearized reading' (duration: 442.26015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:26:55.477847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-02T22:26:55.033923Z","time spent":"443.908505ms","remote":"127.0.0.1:33856","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-02T22:27:11.702072Z","caller":"traceutil/trace.go:171","msg":"trace[1001663684] transaction","detail":"{read_only:false; response_revision:976; number_of_response:1; }","duration":"114.739443ms","start":"2026-04-02T22:27:11.587303Z","end":"2026-04-02T22:27:11.702043Z","steps":["trace[1001663684] 'process raft request' (duration: 41.399582ms)","trace[1001663684] 'compare' (duration: 73.191698ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:11.702355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.546818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-02T22:27:11.702419Z","caller":"traceutil/trace.go:171","msg":"trace[817141073] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:976; }","duration":"114.64372ms","start":"2026-04-02T22:27:11.587757Z","end":"2026-04-02T22:27:11.702401Z","steps":["trace[817141073] 'agreement among raft nodes before linearized reading' (duration: 114.431744ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:27:11.702638Z","caller":"traceutil/trace.go:171","msg":"trace[319678079] linearizableReadLoop","detail":"{readStateIndex:1006; appliedIndex:1005; }","duration":"114.21877ms","start":"2026-04-02T22:27:11.587782Z","end":"2026-04-02T22:27:11.702001Z","steps":["trace[319678079] 'read index received' (duration: 40.846959ms)","trace[319678079] 'applied index is now lower than readState.Index' (duration: 73.370821ms)"],"step_count":2} {"level":"warn","ts":"2026-04-02T22:27:11.702997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.223261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-02T22:27:11.703044Z","caller":"traceutil/trace.go:171","msg":"trace[990523707] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:976; }","duration":"114.310564ms","start":"2026-04-02T22:27:11.588719Z","end":"2026-04-02T22:27:11.70303Z","steps":["trace[990523707] 'agreement among raft nodes before linearized reading' (duration: 114.103569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-02T22:27:11.703164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.422788ms","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-02T22:27:11.703215Z","caller":"traceutil/trace.go:171","msg":"trace[36999861] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:976; }","duration":"109.518691ms","start":"2026-04-02T22:27:11.593685Z","end":"2026-04-02T22:27:11.703203Z","steps":["trace[36999861] 'agreement among raft nodes before linearized reading' (duration: 109.377687ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:50.320265Z","caller":"traceutil/trace.go:171","msg":"trace[416197558] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"129.05161ms","start":"2026-04-02T22:28:50.191194Z","end":"2026-04-02T22:28:50.320246Z","steps":["trace[416197558] 'process raft request' (duration: 128.922478ms)"],"step_count":1} {"level":"info","ts":"2026-04-02T22:28:51.195162Z","caller":"traceutil/trace.go:171","msg":"trace[647786449] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"160.554828ms","start":"2026-04-02T22:28:51.034583Z","end":"2026-04-02T22:28:51.195138Z","steps":["trace[647786449] 'process raft request' (duration: 160.280455ms)"],"step_count":1}