{"level":"warn","ts":"2026-05-25T10:07:02.480295Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-25T10:07:02.480377Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.20:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.20:2380","--initial-cluster=instance=https://199.19.213.20:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.20:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.20:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-25T10:07:02.480438Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-25T10:07:02.480448Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-05-25T10:07:02.480464Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-25T10:07:02.480996Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"]} {"level":"info","ts":"2026-05-25T10:07:02.481064Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.20:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-25T10:07:02.486144Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.885039ms"} {"level":"info","ts":"2026-05-25T10:07:02.493414Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"185293d8d40ffce0","cluster-id":"cc857afa6e1fa648"} {"level":"info","ts":"2026-05-25T10:07:02.493526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=()"} {"level":"info","ts":"2026-05-25T10:07:02.49359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 0"} {"level":"info","ts":"2026-05-25T10:07:02.493673Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 185293d8d40ffce0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-25T10:07:02.49376Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became follower at term 1"} {"level":"info","ts":"2026-05-25T10:07:02.49385Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"warn","ts":"2026-05-25T10:07:02.500895Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-25T10:07:02.503519Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-25T10:07:02.504622Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-25T10:07:02.506866Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"185293d8d40ffce0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-25T10:07:02.511367Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"185293d8d40ffce0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-25T10:07:02.511496Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-25T10:07:02.511547Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-25T10:07:02.51156Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-25T10:07:02.514363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 switched to configuration voters=(1752625764480580832)"} {"level":"info","ts":"2026-05-25T10:07:02.515366Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","added-peer-id":"185293d8d40ffce0","added-peer-peer-urls":["https://199.19.213.20:2380"]} {"level":"info","ts":"2026-05-25T10:07:02.516411Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-25T10:07:02.516703Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"185293d8d40ffce0","initial-advertise-peer-urls":["https://199.19.213.20:2380"],"listen-peer-urls":["https://199.19.213.20:2380"],"advertise-client-urls":["https://199.19.213.20:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.20:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-25T10:07:02.516755Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-25T10:07:02.516529Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-05-25T10:07:02.516973Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.20:2380"} {"level":"info","ts":"2026-05-25T10:07:02.594304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 is starting a new election at term 1"} {"level":"info","ts":"2026-05-25T10:07:02.594503Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-25T10:07:02.594653Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgPreVoteResp from 185293d8d40ffce0 at term 1"} {"level":"info","ts":"2026-05-25T10:07:02.594762Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became candidate at term 2"} {"level":"info","ts":"2026-05-25T10:07:02.594902Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 received MsgVoteResp from 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-05-25T10:07:02.595129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"185293d8d40ffce0 became leader at term 2"} {"level":"info","ts":"2026-05-25T10:07:02.595211Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 185293d8d40ffce0 elected leader 185293d8d40ffce0 at term 2"} {"level":"info","ts":"2026-05-25T10:07:02.596154Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"185293d8d40ffce0","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.20:2379]}","request-path":"/0/members/185293d8d40ffce0/attributes","cluster-id":"cc857afa6e1fa648","publish-timeout":"7s"} {"level":"info","ts":"2026-05-25T10:07:02.596255Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T10:07:02.596304Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-25T10:07:02.596331Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:07:02.596566Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-25T10:07:02.597069Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-25T10:07:02.597588Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cc857afa6e1fa648","local-member-id":"185293d8d40ffce0","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:07:02.597693Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:07:02.597736Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-25T10:07:02.600951Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-25T10:07:02.606248Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.20:2379"} {"level":"info","ts":"2026-05-25T10:07:04.279786Z","caller":"traceutil/trace.go:171","msg":"trace[680407944] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"200.571487ms","start":"2026-05-25T10:07:04.079186Z","end":"2026-05-25T10:07:04.279758Z","steps":["trace[680407944] 'process raft request' (duration: 200.284874ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:04.586614Z","caller":"traceutil/trace.go:171","msg":"trace[1369040580] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"448.951571ms","start":"2026-05-25T10:07:04.137629Z","end":"2026-05-25T10:07:04.586581Z","steps":["trace[1369040580] 'process raft request' (duration: 448.783569ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:04.586728Z","caller":"traceutil/trace.go:171","msg":"trace[50447901] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"495.125441ms","start":"2026-05-25T10:07:04.091579Z","end":"2026-05-25T10:07:04.586704Z","steps":["trace[50447901] 'read index received' (duration: 187.933936ms)","trace[50447901] 'applied index is now lower than readState.Index' (duration: 307.190415ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:07:04.586948Z","caller":"traceutil/trace.go:171","msg":"trace[679001293] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"448.612127ms","start":"2026-05-25T10:07:04.138302Z","end":"2026-05-25T10:07:04.586915Z","steps":["trace[679001293] 'process raft request' (duration: 448.316394ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:04.587027Z","caller":"traceutil/trace.go:171","msg":"trace[836616567] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"420.865508ms","start":"2026-05-25T10:07:04.166142Z","end":"2026-05-25T10:07:04.587008Z","steps":["trace[836616567] 'process raft request' (duration: 420.501693ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:04.586987Z","caller":"traceutil/trace.go:171","msg":"trace[1670670768] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"448.886121ms","start":"2026-05-25T10:07:04.138003Z","end":"2026-05-25T10:07:04.586889Z","steps":["trace[1670670768] 'process raft request' (duration: 448.477526ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.587794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.137603Z","time spent":"449.089614ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T10:07:04.588023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.765386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-25T10:07:04.588102Z","caller":"traceutil/trace.go:171","msg":"trace[1285108499] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"457.865338ms","start":"2026-05-25T10:07:04.130202Z","end":"2026-05-25T10:07:04.588068Z","steps":["trace[1285108499] 'agreement among raft nodes before linearized reading' (duration: 456.798805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.588146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.130185Z","time spent":"457.950369ms","remote":"127.0.0.1:43966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-25T10:07:04.588199Z","caller":"traceutil/trace.go:171","msg":"trace[1165305791] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"449.917333ms","start":"2026-05-25T10:07:04.138235Z","end":"2026-05-25T10:07:04.588153Z","steps":["trace[1165305791] 'process raft request' (duration: 448.357285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.588369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.138216Z","time spent":"450.084355ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-25T10:07:04.588409Z","caller":"traceutil/trace.go:171","msg":"trace[1661404445] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"450.47686ms","start":"2026-05-25T10:07:04.137825Z","end":"2026-05-25T10:07:04.588302Z","steps":["trace[1661404445] 'process raft request' (duration: 448.626068ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.588722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.138292Z","time spent":"448.72535ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T10:07:04.589072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.477463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-25T10:07:04.589141Z","caller":"traceutil/trace.go:171","msg":"trace[45129891] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"367.600524ms","start":"2026-05-25T10:07:04.221518Z","end":"2026-05-25T10:07:04.589119Z","steps":["trace[45129891] 'agreement among raft nodes before linearized reading' (duration: 365.58432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.589174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.2215Z","time spent":"367.666445ms","remote":"127.0.0.1:43966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-25T10:07:04.589546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.10073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.20\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-25T10:07:04.589718Z","caller":"traceutil/trace.go:171","msg":"trace[2035702171] range","detail":"{range_begin:/registry/masterleases/199.19.213.20; range_end:; response_count:0; response_revision:11; }","duration":"452.18387ms","start":"2026-05-25T10:07:04.137404Z","end":"2026-05-25T10:07:04.589588Z","steps":["trace[2035702171] 'agreement among raft nodes before linearized reading' (duration: 451.119018ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:04.58895Z","caller":"traceutil/trace.go:171","msg":"trace[2015797011] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"448.934862ms","start":"2026-05-25T10:07:04.138167Z","end":"2026-05-25T10:07:04.587102Z","steps":["trace[2015797011] 'process raft request' (duration: 448.358665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.589837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.137393Z","time spent":"452.370272ms","remote":"127.0.0.1:43852","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.20\" "} {"level":"warn","ts":"2026-05-25T10:07:04.58983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.138148Z","time spent":"451.645214ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-25T10:07:04.589912Z","caller":"traceutil/trace.go:171","msg":"trace[750181375] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"414.773625ms","start":"2026-05-25T10:07:04.17512Z","end":"2026-05-25T10:07:04.589894Z","steps":["trace[750181375] 'process raft request' (duration: 411.555227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.589927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.400675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-25T10:07:04.589999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.175107Z","time spent":"414.853646ms","remote":"127.0.0.1:44130","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-25T10:07:04.590026Z","caller":"traceutil/trace.go:171","msg":"trace[694970992] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"453.522966ms","start":"2026-05-25T10:07:04.136478Z","end":"2026-05-25T10:07:04.590001Z","steps":["trace[694970992] 'agreement among raft nodes before linearized reading' (duration: 453.382505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.59008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.136464Z","time spent":"453.606147ms","remote":"127.0.0.1:43966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-25T10:07:04.590254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.657113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-25T10:07:04.590307Z","caller":"traceutil/trace.go:171","msg":"trace[2092812315] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"498.732814ms","start":"2026-05-25T10:07:04.091555Z","end":"2026-05-25T10:07:04.590288Z","steps":["trace[2092812315] 'agreement among raft nodes before linearized reading' (duration: 498.648523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.590347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.091537Z","time spent":"498.802435ms","remote":"127.0.0.1:44274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-25T10:07:04.590388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.16613Z","time spent":"420.955498ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T10:07:04.59069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.137991Z","time spent":"449.109414ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-25T10:07:04.590809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.215053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-25T10:07:04.590851Z","caller":"traceutil/trace.go:171","msg":"trace[526836381] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"453.264243ms","start":"2026-05-25T10:07:04.137569Z","end":"2026-05-25T10:07:04.590834Z","steps":["trace[526836381] 'agreement among raft nodes before linearized reading' (duration: 449.548279ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.590878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.137563Z","time spent":"453.308024ms","remote":"127.0.0.1:43932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-25T10:07:04.590988Z","caller":"traceutil/trace.go:171","msg":"trace[748472610] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"507.790011ms","start":"2026-05-25T10:07:04.079374Z","end":"2026-05-25T10:07:04.587164Z","steps":["trace[748472610] 'process raft request' (duration: 506.85492ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:04.591382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.079358Z","time spent":"511.77907ms","remote":"127.0.0.1:43902","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T10:07:04.596922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:04.137809Z","time spent":"450.656032ms","remote":"127.0.0.1:44376","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-25T10:07:38.223786Z","caller":"traceutil/trace.go:171","msg":"trace[450590376] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"127.775611ms","start":"2026-05-25T10:07:38.095396Z","end":"2026-05-25T10:07:38.223172Z","steps":["trace[450590376] 'process raft request' (duration: 90.99313ms)","trace[450590376] 'compare' (duration: 32.459646ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:07:38.223826Z","caller":"traceutil/trace.go:171","msg":"trace[2003369764] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"112.079447ms","start":"2026-05-25T10:07:38.111711Z","end":"2026-05-25T10:07:38.22379Z","steps":["trace[2003369764] 'process raft request' (duration: 111.40024ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:38.249889Z","caller":"traceutil/trace.go:171","msg":"trace[224021731] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"111.21908ms","start":"2026-05-25T10:07:38.138571Z","end":"2026-05-25T10:07:38.24979Z","steps":["trace[224021731] 'process raft request' (duration: 111.146946ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:38.250473Z","caller":"traceutil/trace.go:171","msg":"trace[144363643] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"119.916603ms","start":"2026-05-25T10:07:38.130543Z","end":"2026-05-25T10:07:38.25046Z","steps":["trace[144363643] 'process raft request' (duration: 118.835444ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:38.250602Z","caller":"traceutil/trace.go:171","msg":"trace[1645479339] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"112.102118ms","start":"2026-05-25T10:07:38.13849Z","end":"2026-05-25T10:07:38.250592Z","steps":["trace[1645479339] 'process raft request' (duration: 111.049471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:43.755535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.792264ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-25T10:07:43.755683Z","caller":"traceutil/trace.go:171","msg":"trace[1299156359] linearizableReadLoop","detail":"{readStateIndex:610; appliedIndex:609; }","duration":"193.159675ms","start":"2026-05-25T10:07:43.562492Z","end":"2026-05-25T10:07:43.755651Z","steps":["trace[1299156359] 'read index received' (duration: 67.843µs)","trace[1299156359] 'applied index is now lower than readState.Index' (duration: 193.091112ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:07:43.755708Z","caller":"traceutil/trace.go:171","msg":"trace[418996053] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"295.286823ms","start":"2026-05-25T10:07:43.46039Z","end":"2026-05-25T10:07:43.755677Z","steps":["trace[418996053] 'process raft request' (duration: 32.192825ms)","trace[418996053] 'compare' (duration: 262.656456ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:07:43.755764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.278121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:07:43.755787Z","caller":"traceutil/trace.go:171","msg":"trace[2070422862] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:584; }","duration":"193.335395ms","start":"2026-05-25T10:07:43.562445Z","end":"2026-05-25T10:07:43.75578Z","steps":["trace[2070422862] 'agreement among raft nodes before linearized reading' (duration: 193.270791ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:44.398244Z","caller":"traceutil/trace.go:171","msg":"trace[791046417] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"220.337056ms","start":"2026-05-25T10:07:44.177887Z","end":"2026-05-25T10:07:44.398224Z","steps":["trace[791046417] 'process raft request' (duration: 219.518424ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:44.721297Z","caller":"traceutil/trace.go:171","msg":"trace[2000087809] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"306.927615ms","start":"2026-05-25T10:07:44.414349Z","end":"2026-05-25T10:07:44.721276Z","steps":["trace[2000087809] 'process raft request' (duration: 306.792288ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:44.721417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:44.414332Z","time spent":"307.02387ms","remote":"127.0.0.1:44054","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:07:44.78491Z","caller":"traceutil/trace.go:171","msg":"trace[2117757499] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:614; }","duration":"221.693595ms","start":"2026-05-25T10:07:44.563188Z","end":"2026-05-25T10:07:44.784882Z","steps":["trace[2117757499] 'read index received' (duration: 157.998259ms)","trace[2117757499] 'applied index is now lower than readState.Index' (duration: 63.694226ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:07:44.784973Z","caller":"traceutil/trace.go:171","msg":"trace[1333679828] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"331.809739ms","start":"2026-05-25T10:07:44.453138Z","end":"2026-05-25T10:07:44.784948Z","steps":["trace[1333679828] 'process raft request' (duration: 331.591448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:44.785084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:44.45312Z","time spent":"331.887654ms","remote":"127.0.0.1:44360","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-05-25T10:07:44.785142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.942328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:07:44.785213Z","caller":"traceutil/trace.go:171","msg":"trace[1648257021] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"222.011021ms","start":"2026-05-25T10:07:44.563153Z","end":"2026-05-25T10:07:44.785164Z","steps":["trace[1648257021] 'agreement among raft nodes before linearized reading' (duration: 221.863724ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:44.785258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.023422ms","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-05-25T10:07:44.785345Z","caller":"traceutil/trace.go:171","msg":"trace[1152140686] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:590; }","duration":"222.159399ms","start":"2026-05-25T10:07:44.563167Z","end":"2026-05-25T10:07:44.785326Z","steps":["trace[1152140686] 'agreement among raft nodes before linearized reading' (duration: 221.913986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.469025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"682.501727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:07:45.469122Z","caller":"traceutil/trace.go:171","msg":"trace[282336101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:590; }","duration":"682.632923ms","start":"2026-05-25T10:07:44.78647Z","end":"2026-05-25T10:07:45.469103Z","steps":["trace[282336101] 'range keys from in-memory index tree' (duration: 682.378111ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.469162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:44.786416Z","time spent":"682.737499ms","remote":"127.0.0.1:43832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-25T10:07:45.469213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.036751ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-25T10:07:45.469312Z","caller":"traceutil/trace.go:171","msg":"trace[1322202669] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"672.462757ms","start":"2026-05-25T10:07:44.796832Z","end":"2026-05-25T10:07:45.469295Z","steps":["trace[1322202669] 'read index received' (duration: 6.155803ms)","trace[1322202669] 'applied index is now lower than readState.Index' (duration: 666.305814ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:07:45.469409Z","caller":"traceutil/trace.go:171","msg":"trace[1792633146] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"680.574349ms","start":"2026-05-25T10:07:44.788804Z","end":"2026-05-25T10:07:45.469379Z","steps":["trace[1792633146] 'process raft request' (duration: 14.293747ms)","trace[1792633146] 'compare' (duration: 665.900823ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:07:45.46944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"672.609184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:07:45.469478Z","caller":"traceutil/trace.go:171","msg":"trace[849833276] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:591; }","duration":"672.674248ms","start":"2026-05-25T10:07:44.796791Z","end":"2026-05-25T10:07:45.469465Z","steps":["trace[849833276] 'agreement among raft nodes before linearized reading' (duration: 672.589543ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.469519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:44.796754Z","time spent":"672.756502ms","remote":"127.0.0.1:44106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-05-25T10:07:45.469527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:44.788785Z","time spent":"680.679955ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-25T10:07:45.469665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"573.059786ms","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-05-25T10:07:45.469743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"567.913915ms","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-05-25T10:07:45.469789Z","caller":"traceutil/trace.go:171","msg":"trace[1580326032] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:591; }","duration":"573.167622ms","start":"2026-05-25T10:07:44.896578Z","end":"2026-05-25T10:07:45.469745Z","steps":["trace[1580326032] 'agreement among raft nodes before linearized reading' (duration: 572.854556ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.469692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.764886ms","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-05-25T10:07:45.469819Z","caller":"traceutil/trace.go:171","msg":"trace[1261410095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:591; }","duration":"567.993279ms","start":"2026-05-25T10:07:44.901804Z","end":"2026-05-25T10:07:45.469797Z","steps":["trace[1261410095] 'agreement among raft nodes before linearized reading' (duration: 567.767118ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.469835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:44.896515Z","time spent":"573.310279ms","remote":"127.0.0.1:44144","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-05-25T10:07:45.469841Z","caller":"traceutil/trace.go:171","msg":"trace[1074811377] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:591; }","duration":"272.959365ms","start":"2026-05-25T10:07:45.196866Z","end":"2026-05-25T10:07:45.469825Z","steps":["trace[1074811377] 'agreement among raft nodes before linearized reading' (duration: 272.67437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.469858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:44.901702Z","time spent":"568.148027ms","remote":"127.0.0.1:44144","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":"info","ts":"2026-05-25T10:07:45.96716Z","caller":"traceutil/trace.go:171","msg":"trace[3058951] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"493.335006ms","start":"2026-05-25T10:07:45.473474Z","end":"2026-05-25T10:07:45.966809Z","steps":["trace[3058951] 'process raft request' (duration: 478.301081ms)","trace[3058951] 'compare' (duration: 14.910669ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:07:45.967284Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:45.473423Z","time spent":"493.79409ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:07:45.967522Z","caller":"traceutil/trace.go:171","msg":"trace[508051089] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"492.691074ms","start":"2026-05-25T10:07:45.474813Z","end":"2026-05-25T10:07:45.967504Z","steps":["trace[508051089] 'process raft request' (duration: 492.626161ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.967656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:45.474795Z","time spent":"492.816781ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-25T10:07:45.967737Z","caller":"traceutil/trace.go:171","msg":"trace[2023095341] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"493.520415ms","start":"2026-05-25T10:07:45.474204Z","end":"2026-05-25T10:07:45.967725Z","steps":["trace[2023095341] 'process raft request' (duration: 493.159157ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:07:45.9678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:07:45.474184Z","time spent":"493.586079ms","remote":"127.0.0.1:44144","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-05-25T10:07:45.968367Z","caller":"traceutil/trace.go:171","msg":"trace[1677896844] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:617; }","duration":"263.961022ms","start":"2026-05-25T10:07:45.704394Z","end":"2026-05-25T10:07:45.968355Z","steps":["trace[1677896844] 'read index received' (duration: 247.481694ms)","trace[1677896844] 'applied index is now lower than readState.Index' (duration: 16.478478ms)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:07:45.968514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.055446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.20\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-25T10:07:45.968553Z","caller":"traceutil/trace.go:171","msg":"trace[1623857906] range","detail":"{range_begin:/registry/masterleases/199.19.213.20; range_end:; response_count:1; response_revision:596; }","duration":"264.183312ms","start":"2026-05-25T10:07:45.704358Z","end":"2026-05-25T10:07:45.968541Z","steps":["trace[1623857906] 'agreement among raft nodes before linearized reading' (duration: 264.040135ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:45.968272Z","caller":"traceutil/trace.go:171","msg":"trace[1704377281] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"264.196893ms","start":"2026-05-25T10:07:45.704041Z","end":"2026-05-25T10:07:45.968238Z","steps":["trace[1704377281] 'process raft request' (duration: 263.435545ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:56.838444Z","caller":"traceutil/trace.go:171","msg":"trace[1693152929] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"100.955661ms","start":"2026-05-25T10:07:56.737467Z","end":"2026-05-25T10:07:56.838423Z","steps":["trace[1693152929] 'process raft request' (duration: 100.817035ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:07:56.973532Z","caller":"traceutil/trace.go:171","msg":"trace[607684733] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"127.246913ms","start":"2026-05-25T10:07:56.846254Z","end":"2026-05-25T10:07:56.973501Z","steps":["trace[607684733] 'process raft request' (duration: 112.672203ms)","trace[607684733] 'compare' (duration: 14.369241ms)"],"step_count":2} {"level":"info","ts":"2026-05-25T10:07:56.990237Z","caller":"traceutil/trace.go:171","msg":"trace[1603671019] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"139.568292ms","start":"2026-05-25T10:07:56.850651Z","end":"2026-05-25T10:07:56.990219Z","steps":["trace[1603671019] 'process raft request' (duration: 139.458227ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:08:02.623616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.296176ms","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-05-25T10:08:02.623746Z","caller":"traceutil/trace.go:171","msg":"trace[1930149022] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:761; }","duration":"572.475144ms","start":"2026-05-25T10:08:02.051258Z","end":"2026-05-25T10:08:02.623734Z","steps":["trace[1930149022] 'range keys from in-memory index tree' (duration: 572.14945ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:08:02.623785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:08:02.051238Z","time spent":"572.541076ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-25T10:08:02.62406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.170203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-25T10:08:02.624035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.358296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-25T10:08:02.624129Z","caller":"traceutil/trace.go:171","msg":"trace[153564641] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:761; }","duration":"555.494201ms","start":"2026-05-25T10:08:02.06862Z","end":"2026-05-25T10:08:02.624114Z","steps":["trace[153564641] 'range keys from in-memory index tree' (duration: 555.236751ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:08:02.624174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:08:02.068605Z","time spent":"555.560825ms","remote":"127.0.0.1:44144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-25T10:08:02.624129Z","caller":"traceutil/trace.go:171","msg":"trace[977748483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:761; }","duration":"483.278907ms","start":"2026-05-25T10:08:02.14083Z","end":"2026-05-25T10:08:02.624109Z","steps":["trace[977748483] 'range keys from in-memory index tree' (duration: 482.899832ms)"],"step_count":1} {"level":"warn","ts":"2026-05-25T10:08:02.624253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-25T10:08:02.14081Z","time spent":"483.409633ms","remote":"127.0.0.1:44144","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-05-25T10:08:02.708493Z","caller":"traceutil/trace.go:171","msg":"trace[355127504] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"225.885549ms","start":"2026-05-25T10:08:02.482577Z","end":"2026-05-25T10:08:02.708463Z","steps":["trace[355127504] 'process raft request' (duration: 225.68762ms)"],"step_count":1} {"level":"info","ts":"2026-05-25T10:08:02.708883Z","caller":"traceutil/trace.go:171","msg":"trace[400129814] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:794; }","duration":"145.767094ms","start":"2026-05-25T10:08:02.563085Z","end":"2026-05-25T10:08:02.708853Z","steps":["trace[400129814] 'read index received' (duration: 145.727742ms)","trace[400129814] 'applied index is now lower than readState.Index' (duration: 13.141µs)"],"step_count":2} {"level":"warn","ts":"2026-05-25T10:08:02.709066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.953551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-25T10:08:02.709133Z","caller":"traceutil/trace.go:171","msg":"trace[1313382378] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:762; }","duration":"146.082767ms","start":"2026-05-25T10:08:02.563038Z","end":"2026-05-25T10:08:02.709121Z","steps":["trace[1313382378] 'agreement among raft nodes before linearized reading' (duration: 145.931331ms)"],"step_count":1}