{"level":"warn","ts":"2026-04-07T05:44:26.193783Z","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-07T05:44:26.193932Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70: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.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-07T05:44:26.194034Z","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-07T05:44:26.194073Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-07T05:44:26.194111Z","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-07T05:44:26.194945Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-04-07T05:44:26.195066Z","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.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-07T05:44:26.198777Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.433676ms"} {"level":"info","ts":"2026-04-07T05:44:26.214752Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-04-07T05:44:26.214926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-04-07T05:44:26.214999Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-04-07T05:44:26.215068Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-07T05:44:26.215192Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-04-07T05:44:26.215423Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-04-07T05:44:26.225529Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-07T05:44:26.229128Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-07T05:44:26.230313Z","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-07T05:44:26.232934Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-07T05:44:26.233113Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-07T05:44:26.233388Z","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-07T05:44:26.233427Z","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-07T05:44:26.233437Z","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-07T05:44:26.234253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-04-07T05:44:26.234364Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-04-07T05:44:26.236037Z","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-07T05:44:26.236294Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-07T05:44:26.236328Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-07T05:44:26.236465Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-07T05:44:26.23648Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-04-07T05:44:26.316798Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-04-07T05:44:26.316859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-07T05:44:26.316897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-04-07T05:44:26.316917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-04-07T05:44:26.316928Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-07T05:44:26.316944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-04-07T05:44:26.31697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-04-07T05:44:26.318023Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-04-07T05:44:26.318169Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:44:26.318199Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-07T05:44:26.318303Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:44:26.31859Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-07T05:44:26.31943Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-07T05:44:26.319556Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:44:26.319673Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:44:26.319721Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-07T05:44:26.32142Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-04-07T05:44:26.322166Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-04-07T05:44:28.68376Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566213910161526,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T05:44:28.970509Z","caller":"traceutil/trace.go:171","msg":"trace[1862333619] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"787.828532ms","start":"2026-04-07T05:44:28.182504Z","end":"2026-04-07T05:44:28.970332Z","steps":["trace[1862333619] 'process raft request' (duration: 787.623409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:28.972425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.18249Z","time spent":"789.388828ms","remote":"127.0.0.1:40342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3158,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:29.958894Z","caller":"traceutil/trace.go:171","msg":"trace[247108907] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"1.776000064s","start":"2026-04-07T05:44:28.182859Z","end":"2026-04-07T05:44:29.958859Z","steps":["trace[247108907] 'process raft request' (duration: 1.775945583s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:29.958961Z","caller":"traceutil/trace.go:171","msg":"trace[1811805263] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"1.703322204s","start":"2026-04-07T05:44:28.255627Z","end":"2026-04-07T05:44:29.95895Z","steps":["trace[1811805263] 'process raft request' (duration: 1.703209123s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:29.958951Z","caller":"traceutil/trace.go:171","msg":"trace[1406480430] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"1.703469325s","start":"2026-04-07T05:44:28.25544Z","end":"2026-04-07T05:44:29.958909Z","steps":["trace[1406480430] 'process raft request' (duration: 1.703379684s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:29.95902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.255616Z","time spent":"1.703371774s","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:29.959027Z","caller":"traceutil/trace.go:171","msg":"trace[930599264] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"1.776228475s","start":"2026-04-07T05:44:28.182788Z","end":"2026-04-07T05:44:29.959017Z","steps":["trace[930599264] 'process raft request' (duration: 1.775856112s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:29.959147Z","caller":"traceutil/trace.go:171","msg":"trace[704982950] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"1.703228253s","start":"2026-04-07T05:44:28.255886Z","end":"2026-04-07T05:44:29.959115Z","steps":["trace[704982950] 'process raft request' (duration: 1.703001911s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:29.959256Z","caller":"traceutil/trace.go:171","msg":"trace[1372043338] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"1.703118242s","start":"2026-04-07T05:44:28.256131Z","end":"2026-04-07T05:44:29.959249Z","steps":["trace[1372043338] 'process raft request' (duration: 1.702771557s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:29.959224Z","caller":"traceutil/trace.go:171","msg":"trace[569106046] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"1.703284814s","start":"2026-04-07T05:44:28.255863Z","end":"2026-04-07T05:44:29.959148Z","steps":["trace[569106046] 'process raft request' (duration: 1.702999191s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:29.959285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.182781Z","time spent":"1.776281237s","remote":"127.0.0.1:40226","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-04-07T05:44:29.959315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.256119Z","time spent":"1.703158082s","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:29.959347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.255871Z","time spent":"1.703363025s","remote":"127.0.0.1:40608","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:29.959407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.25584Z","time spent":"1.703495366s","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:29.95951Z","caller":"traceutil/trace.go:171","msg":"trace[529352754] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"1.703763779s","start":"2026-04-07T05:44:28.255698Z","end":"2026-04-07T05:44:29.959462Z","steps":["trace[529352754] 'process raft request' (duration: 1.703150382s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:29.95959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.18285Z","time spent":"1.776121675s","remote":"127.0.0.1:40220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:29.959599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.255689Z","time spent":"1.703859091s","remote":"127.0.0.1:40682","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-04-07T05:44:29.959733Z","caller":"traceutil/trace.go:171","msg":"trace[68484116] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:4; }","duration":"1.776836033s","start":"2026-04-07T05:44:28.182853Z","end":"2026-04-07T05:44:29.959689Z","steps":["trace[68484116] 'read index received' (duration: 787.359937ms)","trace[68484116] 'applied index is now lower than readState.Index' (duration: 989.474126ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:44:29.959792Z","caller":"traceutil/trace.go:171","msg":"trace[296457078] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"1.67995867s","start":"2026-04-07T05:44:28.279825Z","end":"2026-04-07T05:44:29.959784Z","steps":["trace[296457078] 'process raft request' (duration: 1.67909306s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:29.959835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.279814Z","time spent":"1.68000114s","remote":"127.0.0.1:40416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:29.959275Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.255424Z","time spent":"1.703725288s","remote":"127.0.0.1:40682","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-04-07T05:44:29.959915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.777054015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3170"} {"level":"info","ts":"2026-04-07T05:44:29.959967Z","caller":"traceutil/trace.go:171","msg":"trace[557663338] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"1.777116296s","start":"2026-04-07T05:44:28.182838Z","end":"2026-04-07T05:44:29.959954Z","steps":["trace[557663338] 'agreement among raft nodes before linearized reading' (duration: 1.776975934s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:29.960001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.182831Z","time spent":"1.777163256s","remote":"127.0.0.1:40342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3193,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-04-07T05:44:30.143505Z","caller":"traceutil/trace.go:171","msg":"trace[1457354274] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"183.721874ms","start":"2026-04-07T05:44:29.95976Z","end":"2026-04-07T05:44:30.143481Z","steps":["trace[1457354274] 'read index received' (duration: 179.918666ms)","trace[1457354274] 'applied index is now lower than readState.Index' (duration: 3.802348ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:30.143651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.816220948s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:44:30.14371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.830449587s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.143754Z","caller":"traceutil/trace.go:171","msg":"trace[1012487253] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"1.830593129s","start":"2026-04-07T05:44:28.31315Z","end":"2026-04-07T05:44:30.143743Z","steps":["trace[1012487253] 'agreement among raft nodes before linearized reading' (duration: 1.830473717s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.143794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.313139Z","time spent":"1.830647219s","remote":"127.0.0.1:40262","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-04-07T05:44:30.144015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.597925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:44:30.144059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.888167071s","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-04-07T05:44:30.144039Z","caller":"traceutil/trace.go:171","msg":"trace[1249223027] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"1.15986641s","start":"2026-04-07T05:44:28.984135Z","end":"2026-04-07T05:44:30.144001Z","steps":["trace[1249223027] 'process raft request' (duration: 1.155473206s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.1441Z","caller":"traceutil/trace.go:171","msg":"trace[1559271507] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"680.701808ms","start":"2026-04-07T05:44:29.463369Z","end":"2026-04-07T05:44:30.144071Z","steps":["trace[1559271507] 'agreement among raft nodes before linearized reading' (duration: 680.519975ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.144118Z","caller":"traceutil/trace.go:171","msg":"trace[1941541548] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"1.888240072s","start":"2026-04-07T05:44:28.255866Z","end":"2026-04-07T05:44:30.144106Z","steps":["trace[1941541548] 'agreement among raft nodes before linearized reading' (duration: 1.88816821s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.144148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.255859Z","time spent":"1.888281612s","remote":"127.0.0.1:40238","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":"warn","ts":"2026-04-07T05:44:30.144221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.984109Z","time spent":"1.160019352s","remote":"127.0.0.1:40342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3478,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:30.144322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.911590875s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:44:30.144072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.551162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.144352Z","caller":"traceutil/trace.go:171","msg":"trace[1873993024] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:13; }","duration":"1.911650906s","start":"2026-04-07T05:44:28.232692Z","end":"2026-04-07T05:44:30.144343Z","steps":["trace[1873993024] 'agreement among raft nodes before linearized reading' (duration: 1.911560285s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.144376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.232669Z","time spent":"1.911701997s","remote":"127.0.0.1:40262","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-04-07T05:44:30.144367Z","caller":"traceutil/trace.go:171","msg":"trace[43220218] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:12; }","duration":"989.872465ms","start":"2026-04-07T05:44:29.154479Z","end":"2026-04-07T05:44:30.144352Z","steps":["trace[43220218] 'agreement among raft nodes before linearized reading' (duration: 989.507471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.144148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:29.463351Z","time spent":"680.784538ms","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T05:44:30.144453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:29.154465Z","time spent":"989.938146ms","remote":"127.0.0.1:40520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":0,"response size":27,"request content":"key:\"/registry/priorityclasses/system-node-critical\" "} {"level":"info","ts":"2026-04-07T05:44:30.14441Z","caller":"traceutil/trace.go:171","msg":"trace[1619612550] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"181.040747ms","start":"2026-04-07T05:44:29.96335Z","end":"2026-04-07T05:44:30.144391Z","steps":["trace[1619612550] 'process raft request' (duration: 180.750364ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.143716Z","caller":"traceutil/trace.go:171","msg":"trace[651106174] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:0; response_revision:12; }","duration":"1.816325509s","start":"2026-04-07T05:44:28.327372Z","end":"2026-04-07T05:44:30.143698Z","steps":["trace[651106174] 'agreement among raft nodes before linearized reading' (duration: 1.816161057s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.144732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.327366Z","time spent":"1.81735086s","remote":"127.0.0.1:40262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/default\" "} {"level":"warn","ts":"2026-04-07T05:44:30.144906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.890642906s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:44:30.144919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.906065778s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-07T05:44:30.144959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.95708194s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.144968Z","caller":"traceutil/trace.go:171","msg":"trace[2033923138] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:14; }","duration":"1.890725246s","start":"2026-04-07T05:44:28.25422Z","end":"2026-04-07T05:44:30.144945Z","steps":["trace[2033923138] 'agreement among raft nodes before linearized reading' (duration: 1.890307492s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.145013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.890925249s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.145013Z","caller":"traceutil/trace.go:171","msg":"trace[665545051] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:14; }","duration":"1.957158241s","start":"2026-04-07T05:44:28.187839Z","end":"2026-04-07T05:44:30.144997Z","steps":["trace[665545051] 'agreement among raft nodes before linearized reading' (duration: 1.956558615s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.145024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.254187Z","time spent":"1.890824888s","remote":"127.0.0.1:40262","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-04-07T05:44:30.145048Z","caller":"traceutil/trace.go:171","msg":"trace[740462194] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:0; response_revision:14; }","duration":"1.890978319s","start":"2026-04-07T05:44:28.254059Z","end":"2026-04-07T05:44:30.145037Z","steps":["trace[740462194] 'agreement among raft nodes before linearized reading' (duration: 1.890478044s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.14506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.187824Z","time spent":"1.957225331s","remote":"127.0.0.1:40546","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-04-07T05:44:30.145073Z","caller":"traceutil/trace.go:171","msg":"trace[835016803] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"181.553572ms","start":"2026-04-07T05:44:29.963487Z","end":"2026-04-07T05:44:30.145041Z","steps":["trace[835016803] 'process raft request' (duration: 180.730364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.145088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.254047Z","time spent":"1.89103134s","remote":"127.0.0.1:40206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.204.45.70\" "} {"level":"warn","ts":"2026-04-07T05:44:30.145125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.015895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.145163Z","caller":"traceutil/trace.go:171","msg":"trace[314574894] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:14; }","duration":"664.063485ms","start":"2026-04-07T05:44:29.481088Z","end":"2026-04-07T05:44:30.145151Z","steps":["trace[314574894] 'agreement among raft nodes before linearized reading' (duration: 663.090346ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.145191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:29.481082Z","time spent":"664.102536ms","remote":"127.0.0.1:40262","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-04-07T05:44:30.145258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.912354683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.145301Z","caller":"traceutil/trace.go:171","msg":"trace[2005483571] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:14; }","duration":"1.912436844s","start":"2026-04-07T05:44:28.232851Z","end":"2026-04-07T05:44:30.145288Z","steps":["trace[2005483571] 'agreement among raft nodes before linearized reading' (duration: 1.911746507s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.144971Z","caller":"traceutil/trace.go:171","msg":"trace[18444722] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:14; }","duration":"1.906144378s","start":"2026-04-07T05:44:28.23881Z","end":"2026-04-07T05:44:30.144954Z","steps":["trace[18444722] 'agreement among raft nodes before linearized reading' (duration: 1.905737084s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.145341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.232829Z","time spent":"1.912500974s","remote":"127.0.0.1:40262","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-04-07T05:44:30.145355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:28.2388Z","time spent":"1.906542812s","remote":"127.0.0.1:40262","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-04-07T05:44:30.14414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.213498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.145567Z","caller":"traceutil/trace.go:171","msg":"trace[1805816791] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"181.128638ms","start":"2026-04-07T05:44:29.96442Z","end":"2026-04-07T05:44:30.145549Z","steps":["trace[1805816791] 'process raft request' (duration: 180.216249ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.145612Z","caller":"traceutil/trace.go:171","msg":"trace[1413431686] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"181.077798ms","start":"2026-04-07T05:44:29.964523Z","end":"2026-04-07T05:44:30.145601Z","steps":["trace[1413431686] 'process raft request' (duration: 180.920326ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.145606Z","caller":"traceutil/trace.go:171","msg":"trace[1809012001] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:12; }","duration":"991.719824ms","start":"2026-04-07T05:44:29.153871Z","end":"2026-04-07T05:44:30.145591Z","steps":["trace[1809012001] 'agreement among raft nodes before linearized reading' (duration: 990.241179ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.145661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:29.153836Z","time spent":"991.810974ms","remote":"127.0.0.1:40506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" "} {"level":"warn","ts":"2026-04-07T05:44:30.145691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.506761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-4lmzv\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-04-07T05:44:30.145721Z","caller":"traceutil/trace.go:171","msg":"trace[1077137252] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"181.060277ms","start":"2026-04-07T05:44:29.964653Z","end":"2026-04-07T05:44:30.145713Z","steps":["trace[1077137252] 'process raft request' (duration: 180.903425ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.145737Z","caller":"traceutil/trace.go:171","msg":"trace[2067613436] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-4lmzv; range_end:; response_count:1; response_revision:18; }","duration":"182.572342ms","start":"2026-04-07T05:44:29.963151Z","end":"2026-04-07T05:44:30.145724Z","steps":["trace[2067613436] 'agreement among raft nodes before linearized reading' (duration: 182.450531ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:30.145781Z","caller":"traceutil/trace.go:171","msg":"trace[1864784197] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"181.210188ms","start":"2026-04-07T05:44:29.964564Z","end":"2026-04-07T05:44:30.145774Z","steps":["trace[1864784197] 'process raft request' (duration: 180.941716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:30.145878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.305965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-07T05:44:30.145914Z","caller":"traceutil/trace.go:171","msg":"trace[1230574296] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:18; }","duration":"131.367506ms","start":"2026-04-07T05:44:30.014539Z","end":"2026-04-07T05:44:30.145906Z","steps":["trace[1230574296] 'agreement among raft nodes before linearized reading' (duration: 131.317165ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:32.894491Z","caller":"traceutil/trace.go:171","msg":"trace[1616290000] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"178.419558ms","start":"2026-04-07T05:44:32.716045Z","end":"2026-04-07T05:44:32.894465Z","steps":["trace[1616290000] 'process raft request' (duration: 111.204812ms)","trace[1616290000] 'compare' (duration: 66.779122ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:44:32.894864Z","caller":"traceutil/trace.go:171","msg":"trace[948280757] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"174.488059ms","start":"2026-04-07T05:44:32.720346Z","end":"2026-04-07T05:44:32.894834Z","steps":["trace[948280757] 'process raft request' (duration: 173.963254ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:32.894902Z","caller":"traceutil/trace.go:171","msg":"trace[1604039851] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"169.983134ms","start":"2026-04-07T05:44:32.724899Z","end":"2026-04-07T05:44:32.894882Z","steps":["trace[1604039851] 'process raft request' (duration: 169.925743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:32.895015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.155207ms","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-07T05:44:32.895064Z","caller":"traceutil/trace.go:171","msg":"trace[518436398] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:298; }","duration":"171.244808ms","start":"2026-04-07T05:44:32.723809Z","end":"2026-04-07T05:44:32.895054Z","steps":["trace[518436398] 'agreement among raft nodes before linearized reading' (duration: 171.134626ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:32.894918Z","caller":"traceutil/trace.go:171","msg":"trace[433135535] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:303; }","duration":"171.060765ms","start":"2026-04-07T05:44:32.723844Z","end":"2026-04-07T05:44:32.894905Z","steps":["trace[433135535] 'read index received' (duration: 103.415935ms)","trace[433135535] 'applied index is now lower than readState.Index' (duration: 67.64339ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:32.895297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.717513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-07T05:44:32.895372Z","caller":"traceutil/trace.go:171","msg":"trace[1722868154] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:298; }","duration":"152.813755ms","start":"2026-04-07T05:44:32.742532Z","end":"2026-04-07T05:44:32.895346Z","steps":["trace[1722868154] 'agreement among raft nodes before linearized reading' (duration: 152.670534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:33.765962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.870888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3468"} {"level":"info","ts":"2026-04-07T05:44:33.766073Z","caller":"traceutil/trace.go:171","msg":"trace[1493106904] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:307; }","duration":"238.057209ms","start":"2026-04-07T05:44:33.527994Z","end":"2026-04-07T05:44:33.766051Z","steps":["trace[1493106904] 'range keys from in-memory index tree' (duration: 237.740825ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:33.775542Z","caller":"traceutil/trace.go:171","msg":"trace[1070472548] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"246.960866ms","start":"2026-04-07T05:44:33.528551Z","end":"2026-04-07T05:44:33.775512Z","steps":["trace[1070472548] 'process raft request' (duration: 246.838335ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:33.839943Z","caller":"traceutil/trace.go:171","msg":"trace[1364874324] linearizableReadLoop","detail":"{readStateIndex:320; appliedIndex:315; }","duration":"229.139773ms","start":"2026-04-07T05:44:33.610774Z","end":"2026-04-07T05:44:33.839914Z","steps":["trace[1364874324] 'read index received' (duration: 164.48025ms)","trace[1364874324] 'applied index is now lower than readState.Index' (duration: 64.658262ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:44:33.839995Z","caller":"traceutil/trace.go:171","msg":"trace[266875634] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"309.673601ms","start":"2026-04-07T05:44:33.530263Z","end":"2026-04-07T05:44:33.839937Z","steps":["trace[266875634] 'process raft request' (duration: 309.281357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:33.840105Z","caller":"traceutil/trace.go:171","msg":"trace[1539605408] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"309.246797ms","start":"2026-04-07T05:44:33.530805Z","end":"2026-04-07T05:44:33.840052Z","steps":["trace[1539605408] 'process raft request' (duration: 308.995074ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:33.840236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:33.530248Z","time spent":"309.890303ms","remote":"127.0.0.1:40352","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:33.840269Z","caller":"traceutil/trace.go:171","msg":"trace[850597114] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"296.373431ms","start":"2026-04-07T05:44:33.543882Z","end":"2026-04-07T05:44:33.840255Z","steps":["trace[850597114] 'process raft request' (duration: 295.937787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:33.840374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:33.530773Z","time spent":"309.482909ms","remote":"127.0.0.1:40352","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:33.840559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.781328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:44:33.840601Z","caller":"traceutil/trace.go:171","msg":"trace[996325949] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:308; }","duration":"229.891039ms","start":"2026-04-07T05:44:33.610699Z","end":"2026-04-07T05:44:33.84059Z","steps":["trace[996325949] 'agreement among raft nodes before linearized reading' (duration: 229.789408ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:33.840826Z","caller":"traceutil/trace.go:171","msg":"trace[189757966] transaction","detail":"{read_only:false; number_of_response:0; response_revision:307; }","duration":"310.158405ms","start":"2026-04-07T05:44:33.530655Z","end":"2026-04-07T05:44:33.840813Z","steps":["trace[189757966] 'process raft request' (duration: 309.116185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:33.840899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:33.530644Z","time spent":"310.221855ms","remote":"127.0.0.1:40352","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:33.993814Z","caller":"traceutil/trace.go:171","msg":"trace[1705040929] linearizableReadLoop","detail":"{readStateIndex:321; appliedIndex:320; }","duration":"153.747834ms","start":"2026-04-07T05:44:33.840042Z","end":"2026-04-07T05:44:33.99379Z","steps":["trace[1705040929] 'read index received' (duration: 153.716944ms)","trace[1705040929] 'applied index is now lower than readState.Index' (duration: 29.36µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:44:33.99387Z","caller":"traceutil/trace.go:171","msg":"trace[2131550986] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"210.280648ms","start":"2026-04-07T05:44:33.783557Z","end":"2026-04-07T05:44:33.993838Z","steps":["trace[2131550986] 'process raft request' (duration: 210.099796ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:33.994053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.071508ms","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-07T05:44:33.994137Z","caller":"traceutil/trace.go:171","msg":"trace[2127098695] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:309; }","duration":"245.24129ms","start":"2026-04-07T05:44:33.748873Z","end":"2026-04-07T05:44:33.994114Z","steps":["trace[2127098695] 'agreement among raft nodes before linearized reading' (duration: 245.049118ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:33.994562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.851722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-controller-manager-instance\" ","response":"range_response_count:1 size:5513"} {"level":"info","ts":"2026-04-07T05:44:33.994667Z","caller":"traceutil/trace.go:171","msg":"trace[1681092866] range","detail":"{range_begin:/registry/pods/kube-system/kube-controller-manager-instance; range_end:; response_count:1; response_revision:309; }","duration":"218.005903ms","start":"2026-04-07T05:44:33.776636Z","end":"2026-04-07T05:44:33.994642Z","steps":["trace[1681092866] 'agreement among raft nodes before linearized reading' (duration: 217.813362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:34.050424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.609841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:44:34.050476Z","caller":"traceutil/trace.go:171","msg":"trace[53034795] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"206.085722ms","start":"2026-04-07T05:44:33.844366Z","end":"2026-04-07T05:44:34.050451Z","steps":["trace[53034795] 'process raft request' (duration: 205.81895ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:34.05051Z","caller":"traceutil/trace.go:171","msg":"trace[1647507248] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:310; }","duration":"140.759502ms","start":"2026-04-07T05:44:33.909732Z","end":"2026-04-07T05:44:34.050492Z","steps":["trace[1647507248] 'agreement among raft nodes before linearized reading' (duration: 140.58248ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:34.050507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.439133ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:3974"} {"level":"warn","ts":"2026-04-07T05:44:34.050531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.503825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4660"} {"level":"info","ts":"2026-04-07T05:44:34.05059Z","caller":"traceutil/trace.go:171","msg":"trace[1149296047] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:310; }","duration":"208.623625ms","start":"2026-04-07T05:44:33.841954Z","end":"2026-04-07T05:44:34.050577Z","steps":["trace[1149296047] 'agreement among raft nodes before linearized reading' (duration: 208.482134ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:34.050582Z","caller":"traceutil/trace.go:171","msg":"trace[1572146431] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:310; }","duration":"208.558075ms","start":"2026-04-07T05:44:33.842003Z","end":"2026-04-07T05:44:34.050561Z","steps":["trace[1572146431] 'agreement among raft nodes before linearized reading' (duration: 208.411394ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:34.05073Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.560606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:44:34.050832Z","caller":"traceutil/trace.go:171","msg":"trace[274164457] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:310; }","duration":"206.697788ms","start":"2026-04-07T05:44:33.844117Z","end":"2026-04-07T05:44:34.050815Z","steps":["trace[274164457] 'agreement among raft nodes before linearized reading' (duration: 206.367714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:34.050788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.894948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-apiserver-instance\" ","response":"range_response_count:1 size:5892"} {"level":"info","ts":"2026-04-07T05:44:34.051034Z","caller":"traceutil/trace.go:171","msg":"trace[1661479980] range","detail":"{range_begin:/registry/pods/kube-system/kube-apiserver-instance; range_end:; response_count:1; response_revision:310; }","duration":"209.190791ms","start":"2026-04-07T05:44:33.841829Z","end":"2026-04-07T05:44:34.05102Z","steps":["trace[1661479980] 'agreement among raft nodes before linearized reading' (duration: 208.855638ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:35.671133Z","caller":"traceutil/trace.go:171","msg":"trace[1212041488] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"127.573948ms","start":"2026-04-07T05:44:35.543535Z","end":"2026-04-07T05:44:35.671109Z","steps":["trace[1212041488] 'process raft request' (duration: 127.434886ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:35.799835Z","caller":"traceutil/trace.go:171","msg":"trace[1280455373] transaction","detail":"{read_only:false; response_revision:332; number_of_response:1; }","duration":"106.522077ms","start":"2026-04-07T05:44:35.693294Z","end":"2026-04-07T05:44:35.799816Z","steps":["trace[1280455373] 'process raft request' (duration: 101.126107ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.276065Z","caller":"traceutil/trace.go:171","msg":"trace[1180624993] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"267.054369ms","start":"2026-04-07T05:44:56.008987Z","end":"2026-04-07T05:44:56.276042Z","steps":["trace[1180624993] 'process raft request' (duration: 266.734507ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.27664Z","caller":"traceutil/trace.go:171","msg":"trace[1890928000] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"255.298057ms","start":"2026-04-07T05:44:56.021295Z","end":"2026-04-07T05:44:56.276593Z","steps":["trace[1890928000] 'process raft request' (duration: 254.612652ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.276598Z","caller":"traceutil/trace.go:171","msg":"trace[1355572753] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"266.796677ms","start":"2026-04-07T05:44:56.009779Z","end":"2026-04-07T05:44:56.276576Z","steps":["trace[1355572753] 'process raft request' (duration: 266.050111ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.277588Z","caller":"traceutil/trace.go:171","msg":"trace[328965293] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"254.749313ms","start":"2026-04-07T05:44:56.022739Z","end":"2026-04-07T05:44:56.277488Z","steps":["trace[328965293] 'process raft request' (duration: 253.354182ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.277645Z","caller":"traceutil/trace.go:171","msg":"trace[1272722533] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"256.022313ms","start":"2026-04-07T05:44:56.021346Z","end":"2026-04-07T05:44:56.277368Z","steps":["trace[1272722533] 'process raft request' (duration: 254.653153ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.278891Z","caller":"traceutil/trace.go:171","msg":"trace[946465188] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"255.048165ms","start":"2026-04-07T05:44:56.023824Z","end":"2026-04-07T05:44:56.278872Z","steps":["trace[946465188] 'process raft request' (duration: 253.626954ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.279285Z","caller":"traceutil/trace.go:171","msg":"trace[1039243603] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"250.417569ms","start":"2026-04-07T05:44:56.028854Z","end":"2026-04-07T05:44:56.279272Z","steps":["trace[1039243603] 'process raft request' (duration: 249.20028ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.279948Z","caller":"traceutil/trace.go:171","msg":"trace[1894678046] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"246.331327ms","start":"2026-04-07T05:44:56.033475Z","end":"2026-04-07T05:44:56.279807Z","steps":["trace[1894678046] 'process raft request' (duration: 245.174718ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.276118Z","caller":"traceutil/trace.go:171","msg":"trace[261644159] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"256.609358ms","start":"2026-04-07T05:44:56.019481Z","end":"2026-04-07T05:44:56.276091Z","steps":["trace[261644159] 'process raft request' (duration: 256.389657ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.280752Z","caller":"traceutil/trace.go:171","msg":"trace[1893751399] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"221.147192ms","start":"2026-04-07T05:44:56.059569Z","end":"2026-04-07T05:44:56.280716Z","steps":["trace[1893751399] 'process raft request' (duration: 220.97398ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.604182Z","caller":"traceutil/trace.go:171","msg":"trace[957052196] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"507.40537ms","start":"2026-04-07T05:44:56.096728Z","end":"2026-04-07T05:44:56.604133Z","steps":["trace[957052196] 'process raft request' (duration: 507.131128ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.604464Z","caller":"traceutil/trace.go:171","msg":"trace[2113350462] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"507.634771ms","start":"2026-04-07T05:44:56.096748Z","end":"2026-04-07T05:44:56.604383Z","steps":["trace[2113350462] 'process raft request' (duration: 507.302979ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.604624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.096731Z","time spent":"507.818663ms","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:56.60488Z","caller":"traceutil/trace.go:171","msg":"trace[966002486] transaction","detail":"{read_only:false; number_of_response:1; response_revision:519; }","duration":"508.053314ms","start":"2026-04-07T05:44:56.096794Z","end":"2026-04-07T05:44:56.604847Z","steps":["trace[966002486] 'process raft request' (duration: 507.5357ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.605027Z","caller":"traceutil/trace.go:171","msg":"trace[1067258788] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"420.781725ms","start":"2026-04-07T05:44:56.184233Z","end":"2026-04-07T05:44:56.605015Z","steps":["trace[1067258788] 'process raft request' (duration: 420.468683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.605101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.184208Z","time spent":"420.861396ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:56.60441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.09671Z","time spent":"507.579451ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6888,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:56.605088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.096788Z","time spent":"508.163025ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":6937,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:56.789456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.506316ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T05:44:56.789754Z","caller":"traceutil/trace.go:171","msg":"trace[1352961382] linearizableReadLoop","detail":"{readStateIndex:539; appliedIndex:530; }","duration":"519.470103ms","start":"2026-04-07T05:44:56.270253Z","end":"2026-04-07T05:44:56.789723Z","steps":["trace[1352961382] 'read index received' (duration: 7.011224ms)","trace[1352961382] 'applied index is now lower than readState.Index' (duration: 512.456319ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:44:56.789905Z","caller":"traceutil/trace.go:171","msg":"trace[1907954189] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"496.827007ms","start":"2026-04-07T05:44:56.293058Z","end":"2026-04-07T05:44:56.789885Z","steps":["trace[1907954189] 'process raft request' (duration: 496.549955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.790027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.293044Z","time spent":"496.933358ms","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:56.790024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.730145ms","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-07T05:44:56.790129Z","caller":"traceutil/trace.go:171","msg":"trace[36172184] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:521; }","duration":"519.878836ms","start":"2026-04-07T05:44:56.270202Z","end":"2026-04-07T05:44:56.790081Z","steps":["trace[36172184] 'agreement among raft nodes before linearized reading' (duration: 519.588683ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.790151Z","caller":"traceutil/trace.go:171","msg":"trace[1977260836] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"497.016248ms","start":"2026-04-07T05:44:56.293111Z","end":"2026-04-07T05:44:56.790127Z","steps":["trace[1977260836] 'process raft request' (duration: 496.652935ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.790207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.270181Z","time spent":"519.988907ms","remote":"127.0.0.1:40424","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":"warn","ts":"2026-04-07T05:44:56.790242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.293107Z","time spent":"497.092398ms","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:56.790371Z","caller":"traceutil/trace.go:171","msg":"trace[380837353] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"497.081878ms","start":"2026-04-07T05:44:56.293251Z","end":"2026-04-07T05:44:56.790333Z","steps":["trace[380837353] 'process raft request' (duration: 496.832677ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.790552Z","caller":"traceutil/trace.go:171","msg":"trace[819152739] transaction","detail":"{read_only:false; response_revision:524; number_of_response:1; }","duration":"496.799378ms","start":"2026-04-07T05:44:56.293739Z","end":"2026-04-07T05:44:56.790538Z","steps":["trace[819152739] 'process raft request' (duration: 496.481305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.790551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.293245Z","time spent":"497.17459ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:56.790657Z","caller":"traceutil/trace.go:171","msg":"trace[1166926815] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"486.318186ms","start":"2026-04-07T05:44:56.304333Z","end":"2026-04-07T05:44:56.790651Z","steps":["trace[1166926815] 'process raft request' (duration: 486.280356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.790658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.293733Z","time spent":"496.857818ms","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:56.790707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.304325Z","time spent":"486.353556ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:56.790802Z","caller":"traceutil/trace.go:171","msg":"trace[1080882705] transaction","detail":"{read_only:false; response_revision:525; number_of_response:1; }","duration":"490.419818ms","start":"2026-04-07T05:44:56.300364Z","end":"2026-04-07T05:44:56.790784Z","steps":["trace[1080882705] 'process raft request' (duration: 490.003325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.790891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.300354Z","time spent":"490.507118ms","remote":"127.0.0.1:40682","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:56.790814Z","caller":"traceutil/trace.go:171","msg":"trace[905049247] transaction","detail":"{read_only:false; response_revision:526; number_of_response:1; }","duration":"490.231896ms","start":"2026-04-07T05:44:56.300569Z","end":"2026-04-07T05:44:56.790801Z","steps":["trace[905049247] 'process raft request' (duration: 489.883893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.79121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.300548Z","time spent":"490.588908ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:56.790821Z","caller":"traceutil/trace.go:171","msg":"trace[553349879] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"490.170806ms","start":"2026-04-07T05:44:56.300643Z","end":"2026-04-07T05:44:56.790813Z","steps":["trace[553349879] 'process raft request' (duration: 489.920294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.79127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.300637Z","time spent":"490.613739ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:56.881598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.239461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:44:56.881676Z","caller":"traceutil/trace.go:171","msg":"trace[2011434435] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:530; }","duration":"519.363853ms","start":"2026-04-07T05:44:56.362294Z","end":"2026-04-07T05:44:56.881658Z","steps":["trace[2011434435] 'agreement among raft nodes before linearized reading' (duration: 519.226952ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.881754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.362276Z","time spent":"519.466423ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T05:44:56.881985Z","caller":"traceutil/trace.go:171","msg":"trace[1835214587] transaction","detail":"{read_only:false; number_of_response:1; response_revision:528; }","duration":"264.899471ms","start":"2026-04-07T05:44:56.617073Z","end":"2026-04-07T05:44:56.881973Z","steps":["trace[1835214587] 'process raft request' (duration: 264.104145ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.882249Z","caller":"traceutil/trace.go:171","msg":"trace[1998534580] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"260.733629ms","start":"2026-04-07T05:44:56.621505Z","end":"2026-04-07T05:44:56.882239Z","steps":["trace[1998534580] 'process raft request' (duration: 259.841482ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:56.882368Z","caller":"traceutil/trace.go:171","msg":"trace[1911358775] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"221.068211ms","start":"2026-04-07T05:44:56.661291Z","end":"2026-04-07T05:44:56.882359Z","steps":["trace[1911358775] 'process raft request' (duration: 220.191264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.882501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.323112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:44:56.882546Z","caller":"traceutil/trace.go:171","msg":"trace[1755250249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:530; }","duration":"519.386152ms","start":"2026-04-07T05:44:56.363149Z","end":"2026-04-07T05:44:56.882535Z","steps":["trace[1755250249] 'agreement among raft nodes before linearized reading' (duration: 519.315352ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:56.882585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:56.363142Z","time spent":"519.435532ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T05:44:57.069439Z","caller":"traceutil/trace.go:171","msg":"trace[1321230226] transaction","detail":"{read_only:false; number_of_response:0; response_revision:530; }","duration":"274.939686ms","start":"2026-04-07T05:44:56.794472Z","end":"2026-04-07T05:44:57.069412Z","steps":["trace[1321230226] 'process raft request' (duration: 256.967497ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.069663Z","caller":"traceutil/trace.go:171","msg":"trace[1338069079] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"271.911893ms","start":"2026-04-07T05:44:56.797727Z","end":"2026-04-07T05:44:57.069639Z","steps":["trace[1338069079] 'process raft request' (duration: 271.60133ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.070014Z","caller":"traceutil/trace.go:171","msg":"trace[173354728] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"248.758931ms","start":"2026-04-07T05:44:56.821238Z","end":"2026-04-07T05:44:57.069997Z","steps":["trace[173354728] 'process raft request' (duration: 248.240007ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.070267Z","caller":"traceutil/trace.go:171","msg":"trace[354261513] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"248.070996ms","start":"2026-04-07T05:44:56.822181Z","end":"2026-04-07T05:44:57.070252Z","steps":["trace[354261513] 'process raft request' (duration: 247.730084ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.070546Z","caller":"traceutil/trace.go:171","msg":"trace[1719516020] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"210.00496ms","start":"2026-04-07T05:44:56.860515Z","end":"2026-04-07T05:44:57.07052Z","steps":["trace[1719516020] 'process raft request' (duration: 209.604356ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.076953Z","caller":"traceutil/trace.go:171","msg":"trace[612709044] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"185.969493ms","start":"2026-04-07T05:44:56.890967Z","end":"2026-04-07T05:44:57.076936Z","steps":["trace[612709044] 'process raft request' (duration: 185.805222ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.076989Z","caller":"traceutil/trace.go:171","msg":"trace[823312695] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"181.76656ms","start":"2026-04-07T05:44:56.895191Z","end":"2026-04-07T05:44:57.076958Z","steps":["trace[823312695] 'process raft request' (duration: 181.625809ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.077171Z","caller":"traceutil/trace.go:171","msg":"trace[469223264] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"187.428465ms","start":"2026-04-07T05:44:56.889727Z","end":"2026-04-07T05:44:57.077155Z","steps":["trace[469223264] 'process raft request' (duration: 186.913171ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.07745Z","caller":"traceutil/trace.go:171","msg":"trace[404325788] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"181.020945ms","start":"2026-04-07T05:44:56.896391Z","end":"2026-04-07T05:44:57.077411Z","steps":["trace[404325788] 'process raft request' (duration: 180.470901ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:57.079074Z","caller":"traceutil/trace.go:171","msg":"trace[1662458598] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"115.122703ms","start":"2026-04-07T05:44:56.963932Z","end":"2026-04-07T05:44:57.079055Z","steps":["trace[1662458598] 'process raft request' (duration: 113.035986ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:57.930005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"671.620058ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-07T05:44:57.930145Z","caller":"traceutil/trace.go:171","msg":"trace[1175341367] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"844.935067ms","start":"2026-04-07T05:44:57.085187Z","end":"2026-04-07T05:44:57.930122Z","steps":["trace[1175341367] 'process raft request' (duration: 173.049867ms)","trace[1175341367] 'compare' (duration: 671.394276ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:57.930316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:57.085174Z","time spent":"845.067568ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23057,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:58.024136Z","caller":"traceutil/trace.go:171","msg":"trace[652765832] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:560; }","duration":"814.16657ms","start":"2026-04-07T05:44:57.209943Z","end":"2026-04-07T05:44:58.02411Z","steps":["trace[652765832] 'read index received' (duration: 48.375545ms)","trace[652765832] 'applied index is now lower than readState.Index' (duration: 765.789925ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:44:58.024219Z","caller":"traceutil/trace.go:171","msg":"trace[174262792] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"894.086847ms","start":"2026-04-07T05:44:57.130107Z","end":"2026-04-07T05:44:58.024193Z","steps":["trace[174262792] 'process raft request' (duration: 893.945856ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:58.024234Z","caller":"traceutil/trace.go:171","msg":"trace[2055885518] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"918.031612ms","start":"2026-04-07T05:44:57.106158Z","end":"2026-04-07T05:44:58.024189Z","steps":["trace[2055885518] 'process raft request' (duration: 917.75457ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:58.024571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:57.13009Z","time spent":"894.386859ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64392,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:58.024654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:57.106136Z","time spent":"918.381324ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:58.02471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.737324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T05:44:58.025084Z","caller":"traceutil/trace.go:171","msg":"trace[282797461] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:542; }","duration":"815.027406ms","start":"2026-04-07T05:44:57.209898Z","end":"2026-04-07T05:44:58.024925Z","steps":["trace[282797461] 'agreement among raft nodes before linearized reading' (duration: 814.559893ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:58.025177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:57.209877Z","time spent":"815.258138ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T05:44:58.065724Z","caller":"traceutil/trace.go:171","msg":"trace[2128347208] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"123.580542ms","start":"2026-04-07T05:44:57.942106Z","end":"2026-04-07T05:44:58.065686Z","steps":["trace[2128347208] 'process raft request' (duration: 97.257529ms)","trace[2128347208] 'compare' (duration: 26.141442ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:58.065744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.747951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-07T05:44:58.06579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.402892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:44:58.065825Z","caller":"traceutil/trace.go:171","msg":"trace[449316429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:543; }","duration":"203.902203ms","start":"2026-04-07T05:44:57.861906Z","end":"2026-04-07T05:44:58.065808Z","steps":["trace[449316429] 'agreement among raft nodes before linearized reading' (duration: 203.755322ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:58.065872Z","caller":"traceutil/trace.go:171","msg":"trace[384550095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:543; }","duration":"157.525113ms","start":"2026-04-07T05:44:57.908326Z","end":"2026-04-07T05:44:58.065851Z","steps":["trace[384550095] 'agreement among raft nodes before linearized reading' (duration: 157.375552ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:58.424025Z","caller":"traceutil/trace.go:171","msg":"trace[1230727903] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"345.519921ms","start":"2026-04-07T05:44:58.078473Z","end":"2026-04-07T05:44:58.423993Z","steps":["trace[1230727903] 'process raft request' (duration: 267.727094ms)","trace[1230727903] 'compare' (duration: 77.620706ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:58.424191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.078452Z","time spent":"345.655942ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31111,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:58.467677Z","caller":"traceutil/trace.go:171","msg":"trace[1998253061] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"353.966014ms","start":"2026-04-07T05:44:58.113685Z","end":"2026-04-07T05:44:58.467651Z","steps":["trace[1998253061] 'process raft request' (duration: 353.912774ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:58.46782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.113678Z","time spent":"354.074575ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":73770,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:44:58.467964Z","caller":"traceutil/trace.go:171","msg":"trace[1782088269] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"355.080502ms","start":"2026-04-07T05:44:58.112874Z","end":"2026-04-07T05:44:58.467955Z","steps":["trace[1782088269] 'process raft request' (duration: 354.564919ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:58.468024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.112853Z","time spent":"355.131292ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:58.821115Z","caller":"traceutil/trace.go:171","msg":"trace[842596993] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"338.929079ms","start":"2026-04-07T05:44:58.482155Z","end":"2026-04-07T05:44:58.821084Z","steps":["trace[842596993] 'process raft request' (duration: 312.146674ms)","trace[842596993] 'compare' (duration: 26.539493ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:58.821266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.482134Z","time spent":"339.05231ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29546,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:58.858066Z","caller":"traceutil/trace.go:171","msg":"trace[883703747] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"350.318226ms","start":"2026-04-07T05:44:58.50772Z","end":"2026-04-07T05:44:58.858038Z","steps":["trace[883703747] 'process raft request' (duration: 350.233246ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:58.858113Z","caller":"traceutil/trace.go:171","msg":"trace[1532837221] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"355.9945ms","start":"2026-04-07T05:44:58.50209Z","end":"2026-04-07T05:44:58.858085Z","steps":["trace[1532837221] 'process raft request' (duration: 355.699128ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:58.858262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.502065Z","time spent":"356.12619ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19834,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:44:58.858265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.507711Z","time spent":"350.450737ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:59.57507Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566213910162539,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T05:44:59.701213Z","caller":"traceutil/trace.go:171","msg":"trace[83543597] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"787.991885ms","start":"2026-04-07T05:44:58.913192Z","end":"2026-04-07T05:44:59.701184Z","steps":["trace[83543597] 'process raft request' (duration: 726.168094ms)","trace[83543597] 'compare' (duration: 61.565148ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:59.701387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.913154Z","time spent":"788.157777ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":65199,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:44:59.703598Z","caller":"traceutil/trace.go:171","msg":"trace[228534789] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:576; }","duration":"629.27002ms","start":"2026-04-07T05:44:59.0743Z","end":"2026-04-07T05:44:59.70357Z","steps":["trace[228534789] 'read index received' (duration: 565.246454ms)","trace[228534789] 'applied index is now lower than readState.Index' (duration: 64.022426ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:44:59.704385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"630.072208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-07T05:44:59.704414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"624.554525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:44:59.704482Z","caller":"traceutil/trace.go:171","msg":"trace[1649406574] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:558; }","duration":"630.205169ms","start":"2026-04-07T05:44:59.074258Z","end":"2026-04-07T05:44:59.704463Z","steps":["trace[1649406574] 'agreement among raft nodes before linearized reading' (duration: 629.973837ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:59.704505Z","caller":"traceutil/trace.go:171","msg":"trace[513079723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:558; }","duration":"624.695037ms","start":"2026-04-07T05:44:59.079792Z","end":"2026-04-07T05:44:59.704487Z","steps":["trace[513079723] 'agreement among raft nodes before linearized reading' (duration: 624.548866ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:59.704526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.074225Z","time spent":"630.290959ms","remote":"127.0.0.1:40424","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":"warn","ts":"2026-04-07T05:44:59.704549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.07978Z","time spent":"624.758797ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T05:44:59.704579Z","caller":"traceutil/trace.go:171","msg":"trace[319853529] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"784.675428ms","start":"2026-04-07T05:44:58.919867Z","end":"2026-04-07T05:44:59.704543Z","steps":["trace[319853529] 'process raft request' (duration: 782.19707ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:59.704675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:58.919853Z","time spent":"784.77222ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:44:59.704699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"622.898313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:44:59.704736Z","caller":"traceutil/trace.go:171","msg":"trace[2029020597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:558; }","duration":"622.959894ms","start":"2026-04-07T05:44:59.081765Z","end":"2026-04-07T05:44:59.704725Z","steps":["trace[2029020597] 'agreement among raft nodes before linearized reading' (duration: 622.900033ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:44:59.704762Z","caller":"traceutil/trace.go:171","msg":"trace[94534586] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"550.27359ms","start":"2026-04-07T05:44:59.154471Z","end":"2026-04-07T05:44:59.704745Z","steps":["trace[94534586] 'process raft request' (duration: 548.196044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:44:59.704767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.08175Z","time spent":"623.008944ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-07T05:44:59.704833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.154441Z","time spent":"550.356881ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":569094,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:45:00.407399Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566213910162544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T05:45:01.387644Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566213910162544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T05:45:01.888381Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566213910162544,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-07T05:45:01.907606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000481774s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-07T05:45:01.907681Z","caller":"traceutil/trace.go:171","msg":"trace[193142323] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000601755s","start":"2026-04-07T05:44:59.907062Z","end":"2026-04-07T05:45:01.907664Z","steps":["trace[193142323] 'agreement among raft nodes before linearized reading' (duration: 2.000509634s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:01.907729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.907047Z","time spent":"2.000672765s","remote":"127.0.0.1:40194","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/07 05:45:01 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-07T05:45:02.327091Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.618170395s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T05:45:03.650778Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.323329746s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-07T05:45:03.897017Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.569583713s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"warn","ts":"2026-04-07T05:45:03.896368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.377895746s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:03.897185Z","caller":"traceutil/trace.go:171","msg":"trace[833780493] transaction","detail":"{read_only:false; response_revision:560; number_of_response:1; }","duration":"4.18813293s","start":"2026-04-07T05:44:59.709037Z","end":"2026-04-07T05:45:03.89717Z","steps":["trace[833780493] 'process raft request' (duration: 4.18807233s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:03.897196Z","caller":"traceutil/trace.go:171","msg":"trace[860472317] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:558; }","duration":"1.378767282s","start":"2026-04-07T05:45:02.518392Z","end":"2026-04-07T05:45:03.897159Z","steps":["trace[860472317] 'range keys from in-memory index tree' (duration: 1.377859016s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.897233Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.709027Z","time spent":"4.188185151s","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:03.897406Z","caller":"traceutil/trace.go:171","msg":"trace[1418783889] transaction","detail":"{read_only:false; response_revision:559; number_of_response:1; }","duration":"4.188565724s","start":"2026-04-07T05:44:59.708831Z","end":"2026-04-07T05:45:03.897397Z","steps":["trace[1418783889] 'process raft request' (duration: 2.618520327s)","trace[1418783889] 'compare' (duration: 1.569475492s)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:45:03.897445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.708811Z","time spent":"4.188613895s","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:03.897539Z","caller":"traceutil/trace.go:171","msg":"trace[957961091] transaction","detail":"{read_only:false; response_revision:561; number_of_response:1; }","duration":"4.188421753s","start":"2026-04-07T05:44:59.70911Z","end":"2026-04-07T05:45:03.897532Z","steps":["trace[957961091] 'process raft request' (duration: 4.188033629s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.897575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.709096Z","time spent":"4.188458464s","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:03.897742Z","caller":"traceutil/trace.go:171","msg":"trace[1165533893] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"4.166020022s","start":"2026-04-07T05:44:59.731715Z","end":"2026-04-07T05:45:03.897735Z","steps":["trace[1165533893] 'process raft request' (duration: 4.165616039s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.897785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.731683Z","time spent":"4.166076952s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80679,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:03.89776Z","caller":"traceutil/trace.go:171","msg":"trace[467440459] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"4.160902163s","start":"2026-04-07T05:44:59.736836Z","end":"2026-04-07T05:45:03.897738Z","steps":["trace[467440459] 'process raft request' (duration: 4.160710392s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.897883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.736785Z","time spent":"4.161032235s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59616,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:03.897987Z","caller":"traceutil/trace.go:171","msg":"trace[658650407] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"4.08961893s","start":"2026-04-07T05:44:59.80836Z","end":"2026-04-07T05:45:03.897979Z","steps":["trace[658650407] 'process raft request' (duration: 4.089343818s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.898022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:44:59.808326Z","time spent":"4.08967949s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-07T05:45:03.898361Z","caller":"traceutil/trace.go:171","msg":"trace[1871478770] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:579; }","duration":"3.991236381s","start":"2026-04-07T05:44:59.907098Z","end":"2026-04-07T05:45:03.898335Z","steps":["trace[1871478770] 'read index received' (duration: 2.420262678s)","trace[1871478770] 'applied index is now lower than readState.Index' (duration: 1.570971853s)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:03.898853Z","caller":"traceutil/trace.go:171","msg":"trace[3246565] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"2.508530965s","start":"2026-04-07T05:45:01.390297Z","end":"2026-04-07T05:45:03.898828Z","steps":["trace[3246565] 'process raft request' (duration: 2.507643349s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.899044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:01.390288Z","time spent":"2.508634536s","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:45:03.899204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.824466633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T05:45:03.899254Z","caller":"traceutil/trace.go:171","msg":"trace[917773956] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:566; }","duration":"3.824541924s","start":"2026-04-07T05:45:00.074697Z","end":"2026-04-07T05:45:03.899239Z","steps":["trace[917773956] 'agreement among raft nodes before linearized reading' (duration: 3.824311402s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.8993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:00.074684Z","time spent":"3.824603515s","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-07T05:45:03.899287Z","caller":"traceutil/trace.go:171","msg":"trace[505112908] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"744.199086ms","start":"2026-04-07T05:45:03.15506Z","end":"2026-04-07T05:45:03.899259Z","steps":["trace[505112908] 'process raft request' (duration: 743.114988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.899421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:03.155037Z","time spent":"744.311687ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:45:03.899433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.991525293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:03.899474Z","caller":"traceutil/trace.go:171","msg":"trace[1116126007] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"1.991594433s","start":"2026-04-07T05:45:01.907867Z","end":"2026-04-07T05:45:03.899461Z","steps":["trace[1116126007] 'agreement among raft nodes before linearized reading' (duration: 1.991529223s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.899518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:01.907846Z","time spent":"1.991662394s","remote":"127.0.0.1:40178","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-07T05:45:03.899623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.510778631s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-04-07T05:45:03.899658Z","caller":"traceutil/trace.go:171","msg":"trace[945518444] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:566; }","duration":"2.510836822s","start":"2026-04-07T05:45:01.38881Z","end":"2026-04-07T05:45:03.899647Z","steps":["trace[945518444] 'agreement among raft nodes before linearized reading' (duration: 2.510776321s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:03.899687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:01.388795Z","time spent":"2.510885652s","remote":"127.0.0.1:40206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.70\" "} {"level":"warn","ts":"2026-04-07T05:45:05.89218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.831795944s","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-04-07T05:45:05.892266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:03.903718Z","time spent":"1.988544583s","remote":"127.0.0.1:40206","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-07T05:45:05.896393Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.835586861s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T05:45:05.896773Z","caller":"traceutil/trace.go:171","msg":"trace[823767227] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"1.991979427s","start":"2026-04-07T05:45:03.904775Z","end":"2026-04-07T05:45:05.896754Z","steps":["trace[823767227] 'process raft request' (duration: 1.991791076s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:05.896891Z","caller":"traceutil/trace.go:171","msg":"trace[173839793] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"1.992059498s","start":"2026-04-07T05:45:03.904818Z","end":"2026-04-07T05:45:05.896877Z","steps":["trace[173839793] 'process raft request' (duration: 1.991872297s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:05.896878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:03.904749Z","time spent":"1.992085708s","remote":"127.0.0.1:40232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:45:05.89696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:03.904796Z","time spent":"1.992121668s","remote":"127.0.0.1:40424","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-07T05:45:05.897021Z","caller":"traceutil/trace.go:171","msg":"trace[307316408] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"1.983223802s","start":"2026-04-07T05:45:03.913781Z","end":"2026-04-07T05:45:05.897004Z","steps":["trace[307316408] 'process raft request' (duration: 1.98295506s)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:05.89701Z","caller":"traceutil/trace.go:171","msg":"trace[1948083226] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"1.971425415s","start":"2026-04-07T05:45:03.925564Z","end":"2026-04-07T05:45:05.896989Z","steps":["trace[1948083226] 'process raft request' (duration: 1.971228063s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:05.897116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:03.913773Z","time spent":"1.983289403s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:45:05.897159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:03.925544Z","time spent":"1.971531715s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":80688,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:05.897287Z","caller":"traceutil/trace.go:171","msg":"trace[1804496519] linearizableReadLoop","detail":"{readStateIndex:590; appliedIndex:587; }","duration":"1.986691688s","start":"2026-04-07T05:45:03.910586Z","end":"2026-04-07T05:45:05.897277Z","steps":["trace[1804496519] 'read index received' (duration: 149.881458ms)","trace[1804496519] 'applied index is now lower than readState.Index' (duration: 1.83680905s)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:05.897358Z","caller":"traceutil/trace.go:171","msg":"trace[1813326454] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"1.863738398s","start":"2026-04-07T05:45:04.033608Z","end":"2026-04-07T05:45:05.897346Z","steps":["trace[1813326454] 'process raft request' (duration: 1.863322065s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:05.897417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:04.033574Z","time spent":"1.863814889s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":207462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-07T05:45:05.897363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.986774928s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:05.897498Z","caller":"traceutil/trace.go:171","msg":"trace[320697999] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"1.986939699s","start":"2026-04-07T05:45:03.910539Z","end":"2026-04-07T05:45:05.897479Z","steps":["trace[320697999] 'agreement among raft nodes before linearized reading' (duration: 1.986776638s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:05.89758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:03.910532Z","time spent":"1.987028072s","remote":"127.0.0.1:40194","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-07T05:45:06.08457Z","caller":"traceutil/trace.go:171","msg":"trace[1184291389] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"124.779289ms","start":"2026-04-07T05:45:05.959764Z","end":"2026-04-07T05:45:06.084543Z","steps":["trace[1184291389] 'process raft request' (duration: 69.271646ms)","trace[1184291389] 'compare' (duration: 55.373892ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:06.099001Z","caller":"traceutil/trace.go:171","msg":"trace[477570037] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"113.606098ms","start":"2026-04-07T05:45:05.985371Z","end":"2026-04-07T05:45:06.098977Z","steps":["trace[477570037] 'process raft request' (duration: 113.358886ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:06.363673Z","caller":"traceutil/trace.go:171","msg":"trace[348959220] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"200.946453ms","start":"2026-04-07T05:45:06.162698Z","end":"2026-04-07T05:45:06.363644Z","steps":["trace[348959220] 'read index received' (duration: 200.750452ms)","trace[348959220] 'applied index is now lower than readState.Index' (duration: 195.101µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:06.363789Z","caller":"traceutil/trace.go:171","msg":"trace[1178721963] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"203.3105ms","start":"2026-04-07T05:45:06.160465Z","end":"2026-04-07T05:45:06.363775Z","steps":["trace[1178721963] 'process raft request' (duration: 203.056488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.363911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.139125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.363972Z","caller":"traceutil/trace.go:171","msg":"trace[1794966605] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"201.227235ms","start":"2026-04-07T05:45:06.162731Z","end":"2026-04-07T05:45:06.363958Z","steps":["trace[1794966605] 'agreement among raft nodes before linearized reading' (duration: 201.115514ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.364174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.801605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.364221Z","caller":"traceutil/trace.go:171","msg":"trace[356721571] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"169.864437ms","start":"2026-04-07T05:45:06.194345Z","end":"2026-04-07T05:45:06.364209Z","steps":["trace[356721571] 'agreement among raft nodes before linearized reading' (duration: 169.792756ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.364232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.31993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.364815Z","caller":"traceutil/trace.go:171","msg":"trace[1252296370] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"170.927274ms","start":"2026-04-07T05:45:06.193876Z","end":"2026-04-07T05:45:06.364803Z","steps":["trace[1252296370] 'agreement among raft nodes before linearized reading' (duration: 170.32992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.364357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.265084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.365063Z","caller":"traceutil/trace.go:171","msg":"trace[1870193475] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"128.936568ms","start":"2026-04-07T05:45:06.236041Z","end":"2026-04-07T05:45:06.364977Z","steps":["trace[1870193475] 'agreement among raft nodes before linearized reading' (duration: 128.291294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.364179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.179749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.365254Z","caller":"traceutil/trace.go:171","msg":"trace[1920060714] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"171.238726ms","start":"2026-04-07T05:45:06.193955Z","end":"2026-04-07T05:45:06.365194Z","steps":["trace[1920060714] 'agreement among raft nodes before linearized reading' (duration: 170.196888ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.364341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.085603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.36538Z","caller":"traceutil/trace.go:171","msg":"trace[750013938] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:580; }","duration":"129.215292ms","start":"2026-04-07T05:45:06.236142Z","end":"2026-04-07T05:45:06.365357Z","steps":["trace[750013938] 'agreement among raft nodes before linearized reading' (duration: 128.001962ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.364443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.740428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.365543Z","caller":"traceutil/trace.go:171","msg":"trace[773946271] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:580; }","duration":"202.847517ms","start":"2026-04-07T05:45:06.162664Z","end":"2026-04-07T05:45:06.365512Z","steps":["trace[773946271] 'agreement among raft nodes before linearized reading' (duration: 201.718008ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:06.545114Z","caller":"traceutil/trace.go:171","msg":"trace[72829090] linearizableReadLoop","detail":"{readStateIndex:605; appliedIndex:604; }","duration":"104.39104ms","start":"2026-04-07T05:45:06.440696Z","end":"2026-04-07T05:45:06.545087Z","steps":["trace[72829090] 'read index received' (duration: 68.402649ms)","trace[72829090] 'applied index is now lower than readState.Index' (duration: 35.987331ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:06.545623Z","caller":"traceutil/trace.go:171","msg":"trace[314917598] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"156.408468ms","start":"2026-04-07T05:45:06.389196Z","end":"2026-04-07T05:45:06.545604Z","steps":["trace[314917598] 'process raft request' (duration: 119.958623ms)","trace[314917598] 'compare' (duration: 35.77462ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:45:06.545975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.251346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.546028Z","caller":"traceutil/trace.go:171","msg":"trace[224850323] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"105.352447ms","start":"2026-04-07T05:45:06.440662Z","end":"2026-04-07T05:45:06.546015Z","steps":["trace[224850323] 'agreement among raft nodes before linearized reading' (duration: 105.248996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:06.546476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.66077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:06.546604Z","caller":"traceutil/trace.go:171","msg":"trace[947779200] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:581; }","duration":"105.852551ms","start":"2026-04-07T05:45:06.440725Z","end":"2026-04-07T05:45:06.546577Z","steps":["trace[947779200] 'agreement among raft nodes before linearized reading' (duration: 105.582579ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:06.72721Z","caller":"traceutil/trace.go:171","msg":"trace[1191365331] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"158.776356ms","start":"2026-04-07T05:45:06.568401Z","end":"2026-04-07T05:45:06.727178Z","steps":["trace[1191365331] 'process raft request' (duration: 96.772405ms)","trace[1191365331] 'compare' (duration: 61.86576ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:06.736985Z","caller":"traceutil/trace.go:171","msg":"trace[2104342077] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"145.858732ms","start":"2026-04-07T05:45:06.591107Z","end":"2026-04-07T05:45:06.736966Z","steps":["trace[2104342077] 'process raft request' (duration: 145.467989ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:06.870564Z","caller":"traceutil/trace.go:171","msg":"trace[291224784] transaction","detail":"{read_only:false; response_revision:585; number_of_response:1; }","duration":"114.973157ms","start":"2026-04-07T05:45:06.755562Z","end":"2026-04-07T05:45:06.870535Z","steps":["trace[291224784] 'process raft request' (duration: 114.876226ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:06.871256Z","caller":"traceutil/trace.go:171","msg":"trace[132807091] transaction","detail":"{read_only:false; response_revision:584; number_of_response:1; }","duration":"115.678572ms","start":"2026-04-07T05:45:06.755546Z","end":"2026-04-07T05:45:06.871224Z","steps":["trace[132807091] 'process raft request' (duration: 105.442597ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:07.104866Z","caller":"traceutil/trace.go:171","msg":"trace[745439382] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"134.755526ms","start":"2026-04-07T05:45:06.970092Z","end":"2026-04-07T05:45:07.104848Z","steps":["trace[745439382] 'process raft request' (duration: 134.603445ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:07.195437Z","caller":"traceutil/trace.go:171","msg":"trace[788478616] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"148.671626ms","start":"2026-04-07T05:45:07.046743Z","end":"2026-04-07T05:45:07.195415Z","steps":["trace[788478616] 'process raft request' (duration: 148.001481ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:07.475375Z","caller":"traceutil/trace.go:171","msg":"trace[1614696256] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"334.511591ms","start":"2026-04-07T05:45:07.140826Z","end":"2026-04-07T05:45:07.475337Z","steps":["trace[1614696256] 'process raft request' (duration: 295.859951ms)","trace[1614696256] 'compare' (duration: 38.390608ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:45:07.475696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:07.140794Z","time spent":"334.770502ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":74754,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:07.47652Z","caller":"traceutil/trace.go:171","msg":"trace[1695317261] transaction","detail":"{read_only:false; response_revision:592; number_of_response:1; }","duration":"207.732903ms","start":"2026-04-07T05:45:07.268763Z","end":"2026-04-07T05:45:07.476496Z","steps":["trace[1695317261] 'process raft request' (duration: 207.570832ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:07.755607Z","caller":"traceutil/trace.go:171","msg":"trace[453063212] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"266.006274ms","start":"2026-04-07T05:45:07.489568Z","end":"2026-04-07T05:45:07.755574Z","steps":["trace[453063212] 'process raft request' (duration: 210.18821ms)","trace[453063212] 'compare' (duration: 55.643533ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:07.757248Z","caller":"traceutil/trace.go:171","msg":"trace[181669257] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"237.741509ms","start":"2026-04-07T05:45:07.519491Z","end":"2026-04-07T05:45:07.757233Z","steps":["trace[181669257] 'process raft request' (duration: 237.239555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:10.484758Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296566213910162643,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-07T05:45:10.741481Z","caller":"traceutil/trace.go:171","msg":"trace[124764127] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:625; }","duration":"757.523061ms","start":"2026-04-07T05:45:09.983933Z","end":"2026-04-07T05:45:10.741456Z","steps":["trace[124764127] 'read index received' (duration: 757.28869ms)","trace[124764127] 'applied index is now lower than readState.Index' (duration: 233.541µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:10.741569Z","caller":"traceutil/trace.go:171","msg":"trace[1666994909] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"778.873623ms","start":"2026-04-07T05:45:09.962674Z","end":"2026-04-07T05:45:10.741548Z","steps":["trace[1666994909] 'process raft request' (duration: 778.635171ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:10.741695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:09.962652Z","time spent":"778.969444ms","remote":"127.0.0.1:40424","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-04-07T05:45:10.741724Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"757.780213ms","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-07T05:45:10.741772Z","caller":"traceutil/trace.go:171","msg":"trace[1287338817] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:602; }","duration":"757.871014ms","start":"2026-04-07T05:45:09.983889Z","end":"2026-04-07T05:45:10.74176Z","steps":["trace[1287338817] 'agreement among raft nodes before linearized reading' (duration: 757.715412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:10.741808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:09.98387Z","time spent":"757.930734ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-07T05:45:10.741729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.813404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T05:45:10.74189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"753.730523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:45:10.74192Z","caller":"traceutil/trace.go:171","msg":"trace[1667151015] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:602; }","duration":"753.775914ms","start":"2026-04-07T05:45:09.988134Z","end":"2026-04-07T05:45:10.74191Z","steps":["trace[1667151015] 'agreement among raft nodes before linearized reading' (duration: 753.719643ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:10.741943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:09.988123Z","time spent":"753.815484ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-07T05:45:10.741971Z","caller":"traceutil/trace.go:171","msg":"trace[753371685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:602; }","duration":"754.025056ms","start":"2026-04-07T05:45:09.987883Z","end":"2026-04-07T05:45:10.741909Z","steps":["trace[753371685] 'agreement among raft nodes before linearized reading' (duration: 753.787714ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:10.742009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:09.987873Z","time spent":"754.127786ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-07T05:45:10.883286Z","caller":"traceutil/trace.go:171","msg":"trace[123147780] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"135.579135ms","start":"2026-04-07T05:45:10.747681Z","end":"2026-04-07T05:45:10.88326Z","steps":["trace[123147780] 'read index received' (duration: 72.847169ms)","trace[123147780] 'applied index is now lower than readState.Index' (duration: 62.731096ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:10.883316Z","caller":"traceutil/trace.go:171","msg":"trace[419683206] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"136.515701ms","start":"2026-04-07T05:45:10.746778Z","end":"2026-04-07T05:45:10.883294Z","steps":["trace[419683206] 'process raft request' (duration: 136.41134ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:10.883412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.702495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:10.883384Z","caller":"traceutil/trace.go:171","msg":"trace[1877413377] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"133.242287ms","start":"2026-04-07T05:45:10.750102Z","end":"2026-04-07T05:45:10.883345Z","steps":["trace[1877413377] 'process raft request' (duration: 133.126406ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:10.883451Z","caller":"traceutil/trace.go:171","msg":"trace[19266016] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-envoy-gateway-role; range_end:; response_count:0; response_revision:605; }","duration":"135.831176ms","start":"2026-04-07T05:45:10.747605Z","end":"2026-04-07T05:45:10.883436Z","steps":["trace[19266016] 'agreement among raft nodes before linearized reading' (duration: 135.749415ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:10.883434Z","caller":"traceutil/trace.go:171","msg":"trace[38354329] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"137.88636ms","start":"2026-04-07T05:45:10.745499Z","end":"2026-04-07T05:45:10.883385Z","steps":["trace[38354329] 'process raft request' (duration: 75.011724ms)","trace[38354329] 'compare' (duration: 62.534144ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:11.104198Z","caller":"traceutil/trace.go:171","msg":"trace[1739442504] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"179.544287ms","start":"2026-04-07T05:45:10.924632Z","end":"2026-04-07T05:45:11.104176Z","steps":["trace[1739442504] 'process raft request' (duration: 179.496456ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:11.104275Z","caller":"traceutil/trace.go:171","msg":"trace[349915673] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"179.615687ms","start":"2026-04-07T05:45:10.924627Z","end":"2026-04-07T05:45:11.104243Z","steps":["trace[349915673] 'process raft request' (duration: 179.395366ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:12.144773Z","caller":"traceutil/trace.go:171","msg":"trace[1106475576] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"240.551428ms","start":"2026-04-07T05:45:11.904186Z","end":"2026-04-07T05:45:12.144737Z","steps":["trace[1106475576] 'read index received' (duration: 239.596671ms)","trace[1106475576] 'applied index is now lower than readState.Index' (duration: 953.597µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:12.144874Z","caller":"traceutil/trace.go:171","msg":"trace[1154598193] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"249.31367ms","start":"2026-04-07T05:45:11.895522Z","end":"2026-04-07T05:45:12.144836Z","steps":["trace[1154598193] 'process raft request' (duration: 248.494504ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:12.144929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.71729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:12.144971Z","caller":"traceutil/trace.go:171","msg":"trace[179204252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"240.80386ms","start":"2026-04-07T05:45:11.904154Z","end":"2026-04-07T05:45:12.144958Z","steps":["trace[179204252] 'agreement among raft nodes before linearized reading' (duration: 240.709419ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:14.121508Z","caller":"traceutil/trace.go:171","msg":"trace[2049394517] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"158.422485ms","start":"2026-04-07T05:45:13.963053Z","end":"2026-04-07T05:45:14.121476Z","steps":["trace[2049394517] 'process raft request' (duration: 158.224924ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:19.101142Z","caller":"traceutil/trace.go:171","msg":"trace[323804514] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"268.362865ms","start":"2026-04-07T05:45:18.832749Z","end":"2026-04-07T05:45:19.101112Z","steps":["trace[323804514] 'read index received' (duration: 268.058493ms)","trace[323804514] 'applied index is now lower than readState.Index' (duration: 303.312µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:19.101282Z","caller":"traceutil/trace.go:171","msg":"trace[905019056] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"451.246097ms","start":"2026-04-07T05:45:18.650026Z","end":"2026-04-07T05:45:19.101272Z","steps":["trace[905019056] 'process raft request' (duration: 450.870145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:19.101473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:18.650009Z","time spent":"451.386768ms","remote":"127.0.0.1:40352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:45:19.101565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.187716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-07T05:45:19.101563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.668431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:19.101691Z","caller":"traceutil/trace.go:171","msg":"trace[807845890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:647; }","duration":"194.901453ms","start":"2026-04-07T05:45:18.906771Z","end":"2026-04-07T05:45:19.101673Z","steps":["trace[807845890] 'agreement among raft nodes before linearized reading' (duration: 194.675041ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:19.101715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.536157ms","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-07T05:45:19.101782Z","caller":"traceutil/trace.go:171","msg":"trace[1387393059] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:647; }","duration":"179.606897ms","start":"2026-04-07T05:45:18.922151Z","end":"2026-04-07T05:45:19.101758Z","steps":["trace[1387393059] 'agreement among raft nodes before linearized reading' (duration: 179.419806ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:19.101631Z","caller":"traceutil/trace.go:171","msg":"trace[1195040273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:647; }","duration":"172.266866ms","start":"2026-04-07T05:45:18.929348Z","end":"2026-04-07T05:45:19.101615Z","steps":["trace[1195040273] 'agreement among raft nodes before linearized reading' (duration: 172.114895ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:19.102358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.575763ms","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-07T05:45:19.10253Z","caller":"traceutil/trace.go:171","msg":"trace[1293900105] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:647; }","duration":"269.810205ms","start":"2026-04-07T05:45:18.832693Z","end":"2026-04-07T05:45:19.102503Z","steps":["trace[1293900105] 'agreement among raft nodes before linearized reading' (duration: 268.852559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:19.103061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.289112ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:45:19.10311Z","caller":"traceutil/trace.go:171","msg":"trace[358479623] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:647; }","duration":"177.360623ms","start":"2026-04-07T05:45:18.925739Z","end":"2026-04-07T05:45:19.103099Z","steps":["trace[358479623] 'agreement among raft nodes before linearized reading' (duration: 175.734801ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:20.805138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.998271ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-04-07T05:45:20.80526Z","caller":"traceutil/trace.go:171","msg":"trace[1776766220] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"892.967467ms","start":"2026-04-07T05:45:19.912269Z","end":"2026-04-07T05:45:20.805237Z","steps":["trace[1776766220] 'read index received' (duration: 294.839825ms)","trace[1776766220] 'applied index is now lower than readState.Index' (duration: 598.125452ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:45:20.805403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"893.082187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:20.80545Z","caller":"traceutil/trace.go:171","msg":"trace[835900740] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"893.215438ms","start":"2026-04-07T05:45:19.912219Z","end":"2026-04-07T05:45:20.805434Z","steps":["trace[835900740] 'agreement among raft nodes before linearized reading' (duration: 893.080787ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:20.805552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:19.912201Z","time spent":"893.306698ms","remote":"127.0.0.1:40194","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-07T05:45:21.296158Z","caller":"traceutil/trace.go:171","msg":"trace[144775713] linearizableReadLoop","detail":"{readStateIndex:678; appliedIndex:677; }","duration":"160.506096ms","start":"2026-04-07T05:45:21.135632Z","end":"2026-04-07T05:45:21.296138Z","steps":["trace[144775713] 'read index received' (duration: 160.302304ms)","trace[144775713] 'applied index is now lower than readState.Index' (duration: 203.002µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:21.296296Z","caller":"traceutil/trace.go:171","msg":"trace[1724250566] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"173.247241ms","start":"2026-04-07T05:45:21.123019Z","end":"2026-04-07T05:45:21.296267Z","steps":["trace[1724250566] 'process raft request' (duration: 172.978699ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:21.2964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.206573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:45:21.296506Z","caller":"traceutil/trace.go:171","msg":"trace[2092014134] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:652; }","duration":"160.337765ms","start":"2026-04-07T05:45:21.136149Z","end":"2026-04-07T05:45:21.296487Z","steps":["trace[2092014134] 'agreement among raft nodes before linearized reading' (duration: 160.141243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:21.296658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.02333ms","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-07T05:45:21.296698Z","caller":"traceutil/trace.go:171","msg":"trace[1078535693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:652; }","duration":"161.10094ms","start":"2026-04-07T05:45:21.135587Z","end":"2026-04-07T05:45:21.296688Z","steps":["trace[1078535693] 'agreement among raft nodes before linearized reading' (duration: 161.00768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:21.297029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.821961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:45:21.29712Z","caller":"traceutil/trace.go:171","msg":"trace[2095380098] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:652; }","duration":"159.956232ms","start":"2026-04-07T05:45:21.137145Z","end":"2026-04-07T05:45:21.297101Z","steps":["trace[2095380098] 'agreement among raft nodes before linearized reading' (duration: 159.64985ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:23.096685Z","caller":"traceutil/trace.go:171","msg":"trace[2012463043] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"189.672896ms","start":"2026-04-07T05:45:22.90699Z","end":"2026-04-07T05:45:23.096663Z","steps":["trace[2012463043] 'read index received' (duration: 189.410154ms)","trace[2012463043] 'applied index is now lower than readState.Index' (duration: 261.862µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:45:23.096849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.845687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:23.096845Z","caller":"traceutil/trace.go:171","msg":"trace[2028068115] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"342.827208ms","start":"2026-04-07T05:45:22.753989Z","end":"2026-04-07T05:45:23.096816Z","steps":["trace[2028068115] 'process raft request' (duration: 342.537136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:23.09689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.451708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:23.096934Z","caller":"traceutil/trace.go:171","msg":"trace[25535068] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:685; }","duration":"151.533188ms","start":"2026-04-07T05:45:22.945386Z","end":"2026-04-07T05:45:23.096919Z","steps":["trace[25535068] 'agreement among raft nodes before linearized reading' (duration: 151.450498ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:23.096881Z","caller":"traceutil/trace.go:171","msg":"trace[1114498623] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:685; }","duration":"189.933688ms","start":"2026-04-07T05:45:22.906938Z","end":"2026-04-07T05:45:23.096872Z","steps":["trace[1114498623] 'agreement among raft nodes before linearized reading' (duration: 189.854188ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:23.096979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:22.753973Z","time spent":"342.938778ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4059,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:25.501655Z","caller":"traceutil/trace.go:171","msg":"trace[1307004976] transaction","detail":"{read_only:false; response_revision:719; number_of_response:1; }","duration":"102.082752ms","start":"2026-04-07T05:45:25.399547Z","end":"2026-04-07T05:45:25.50163Z","steps":["trace[1307004976] 'process raft request' (duration: 101.930384ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:25.631078Z","caller":"traceutil/trace.go:171","msg":"trace[718714194] transaction","detail":"{read_only:false; response_revision:720; number_of_response:1; }","duration":"114.848762ms","start":"2026-04-07T05:45:25.516194Z","end":"2026-04-07T05:45:25.631043Z","steps":["trace[718714194] 'process raft request' (duration: 76.593912ms)","trace[718714194] 'compare' (duration: 37.973936ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:25.930416Z","caller":"traceutil/trace.go:171","msg":"trace[1394080096] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:749; }","duration":"185.430343ms","start":"2026-04-07T05:45:25.744951Z","end":"2026-04-07T05:45:25.930382Z","steps":["trace[1394080096] 'read index received' (duration: 159.998597ms)","trace[1394080096] 'applied index is now lower than readState.Index' (duration: 25.430055ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:25.930476Z","caller":"traceutil/trace.go:171","msg":"trace[1636032588] transaction","detail":"{read_only:false; response_revision:722; number_of_response:1; }","duration":"239.541108ms","start":"2026-04-07T05:45:25.690891Z","end":"2026-04-07T05:45:25.930432Z","steps":["trace[1636032588] 'process raft request' (duration: 214.037099ms)","trace[1636032588] 'compare' (duration: 25.240506ms)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:45:25.930696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.722607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-04-07T05:45:25.930778Z","caller":"traceutil/trace.go:171","msg":"trace[254786242] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:722; }","duration":"185.845924ms","start":"2026-04-07T05:45:25.744909Z","end":"2026-04-07T05:45:25.930754Z","steps":["trace[254786242] 'agreement among raft nodes before linearized reading' (duration: 185.596602ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:26.164773Z","caller":"traceutil/trace.go:171","msg":"trace[2113973635] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"190.92481ms","start":"2026-04-07T05:45:25.973822Z","end":"2026-04-07T05:45:26.164747Z","steps":["trace[2113973635] 'process raft request' (duration: 180.20474ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:26.323027Z","caller":"traceutil/trace.go:171","msg":"trace[579118053] transaction","detail":"{read_only:false; response_revision:724; number_of_response:1; }","duration":"140.762035ms","start":"2026-04-07T05:45:26.182203Z","end":"2026-04-07T05:45:26.322965Z","steps":["trace[579118053] 'process raft request' (duration: 140.575226ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:26.570338Z","caller":"traceutil/trace.go:171","msg":"trace[265950494] transaction","detail":"{read_only:false; response_revision:726; number_of_response:1; }","duration":"116.566396ms","start":"2026-04-07T05:45:26.453747Z","end":"2026-04-07T05:45:26.570314Z","steps":["trace[265950494] 'process raft request' (duration: 116.25331ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:26.576451Z","caller":"traceutil/trace.go:171","msg":"trace[1385614216] transaction","detail":"{read_only:false; response_revision:727; number_of_response:1; }","duration":"112.292835ms","start":"2026-04-07T05:45:26.464063Z","end":"2026-04-07T05:45:26.576355Z","steps":["trace[1385614216] 'process raft request' (duration: 112.056283ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:26.838741Z","caller":"traceutil/trace.go:171","msg":"trace[1708801032] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"138.82353ms","start":"2026-04-07T05:45:26.699336Z","end":"2026-04-07T05:45:26.838159Z","steps":["trace[1708801032] 'process raft request' (duration: 138.493064ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:35.306442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.892174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:45:35.306536Z","caller":"traceutil/trace.go:171","msg":"trace[623731029] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:797; }","duration":"394.02971ms","start":"2026-04-07T05:45:34.912484Z","end":"2026-04-07T05:45:35.306514Z","steps":["trace[623731029] 'range keys from in-memory index tree' (duration: 393.82622ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:35.306811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:34.91247Z","time spent":"394.295492ms","remote":"127.0.0.1:40194","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-07T05:45:35.313203Z","caller":"traceutil/trace.go:171","msg":"trace[2139507162] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"361.914261ms","start":"2026-04-07T05:45:34.951263Z","end":"2026-04-07T05:45:35.313177Z","steps":["trace[2139507162] 'process raft request' (duration: 361.325845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:35.313367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:34.951239Z","time spent":"362.044137ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-07T05:45:38.974329Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.220030911s","expected-duration":"1s"} {"level":"info","ts":"2026-04-07T05:45:38.974759Z","caller":"traceutil/trace.go:171","msg":"trace[818693060] linearizableReadLoop","detail":"{readStateIndex:849; appliedIndex:848; }","duration":"327.427383ms","start":"2026-04-07T05:45:38.647313Z","end":"2026-04-07T05:45:38.97474Z","steps":["trace[818693060] 'read index received' (duration: 327.12012ms)","trace[818693060] 'applied index is now lower than readState.Index' (duration: 306.533µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:38.975215Z","caller":"traceutil/trace.go:171","msg":"trace[1551652285] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"1.220972311s","start":"2026-04-07T05:45:37.75422Z","end":"2026-04-07T05:45:38.975192Z","steps":["trace[1551652285] 'process raft request' (duration: 1.220301783s)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:38.975258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.924834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-07T05:45:38.975351Z","caller":"traceutil/trace.go:171","msg":"trace[76463079] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:816; }","duration":"328.082501ms","start":"2026-04-07T05:45:38.647249Z","end":"2026-04-07T05:45:38.975331Z","steps":["trace[76463079] 'agreement among raft nodes before linearized reading' (duration: 327.753047ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:45:38.975403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:38.647217Z","time spent":"328.175385ms","remote":"127.0.0.1:40424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-07T05:45:38.975538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-07T05:45:37.754208Z","time spent":"1.221100837s","remote":"127.0.0.1:40352","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-07T05:45:55.657408Z","caller":"traceutil/trace.go:171","msg":"trace[369642211] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"202.49139ms","start":"2026-04-07T05:45:55.454867Z","end":"2026-04-07T05:45:55.657358Z","steps":["trace[369642211] 'process raft request' (duration: 186.889377ms)","trace[369642211] 'compare' (duration: 15.285982ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:45:55.657651Z","caller":"traceutil/trace.go:171","msg":"trace[605383059] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"202.311943ms","start":"2026-04-07T05:45:55.455096Z","end":"2026-04-07T05:45:55.657408Z","steps":["trace[605383059] 'process raft request' (duration: 202.20846ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:45:55.66232Z","caller":"traceutil/trace.go:171","msg":"trace[1697250395] transaction","detail":"{read_only:false; response_revision:1004; number_of_response:1; }","duration":"155.23504ms","start":"2026-04-07T05:45:55.507062Z","end":"2026-04-07T05:45:55.662297Z","steps":["trace[1697250395] 'process raft request' (duration: 155.033862ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:46:44.082778Z","caller":"traceutil/trace.go:171","msg":"trace[653259674] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"162.173342ms","start":"2026-04-07T05:46:43.920578Z","end":"2026-04-07T05:46:44.082751Z","steps":["trace[653259674] 'process raft request' (duration: 148.874278ms)","trace[653259674] 'compare' (duration: 12.901305ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:47:01.975687Z","caller":"traceutil/trace.go:171","msg":"trace[1273238017] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"113.767089ms","start":"2026-04-07T05:47:01.861891Z","end":"2026-04-07T05:47:01.975658Z","steps":["trace[1273238017] 'process raft request' (duration: 113.559255ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:22.306724Z","caller":"traceutil/trace.go:171","msg":"trace[1110163728] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"235.813135ms","start":"2026-04-07T05:47:22.070867Z","end":"2026-04-07T05:47:22.30668Z","steps":["trace[1110163728] 'process raft request' (duration: 235.508ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:22.306931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.118794ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-07T05:47:22.307031Z","caller":"traceutil/trace.go:171","msg":"trace[507912028] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1321; }","duration":"214.263456ms","start":"2026-04-07T05:47:22.092744Z","end":"2026-04-07T05:47:22.307007Z","steps":["trace[507912028] 'agreement among raft nodes before linearized reading' (duration: 214.030702ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:22.307143Z","caller":"traceutil/trace.go:171","msg":"trace[1988567902] linearizableReadLoop","detail":"{readStateIndex:1379; appliedIndex:1378; }","duration":"213.786568ms","start":"2026-04-07T05:47:22.092798Z","end":"2026-04-07T05:47:22.306585Z","steps":["trace[1988567902] 'read index received' (duration: 213.574965ms)","trace[1988567902] 'applied index is now lower than readState.Index' (duration: 210.533µs)"],"step_count":2} {"level":"warn","ts":"2026-04-07T05:47:22.373621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.545336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:47:22.373696Z","caller":"traceutil/trace.go:171","msg":"trace[1110530835] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1322; }","duration":"158.679498ms","start":"2026-04-07T05:47:22.214999Z","end":"2026-04-07T05:47:22.373678Z","steps":["trace[1110530835] 'agreement among raft nodes before linearized reading' (duration: 158.582847ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:22.373778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.1804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-07T05:47:22.373622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.531508ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-07T05:47:22.37383Z","caller":"traceutil/trace.go:171","msg":"trace[1573604150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1322; }","duration":"274.259042ms","start":"2026-04-07T05:47:22.099556Z","end":"2026-04-07T05:47:22.373815Z","steps":["trace[1573604150] 'agreement among raft nodes before linearized reading' (duration: 274.108319ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:22.373997Z","caller":"traceutil/trace.go:171","msg":"trace[1627563813] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1322; }","duration":"280.898164ms","start":"2026-04-07T05:47:22.093039Z","end":"2026-04-07T05:47:22.373937Z","steps":["trace[1627563813] 'agreement among raft nodes before linearized reading' (duration: 280.503987ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:28.012976Z","caller":"traceutil/trace.go:171","msg":"trace[392461041] linearizableReadLoop","detail":"{readStateIndex:1403; appliedIndex:1402; }","duration":"163.661095ms","start":"2026-04-07T05:47:27.849294Z","end":"2026-04-07T05:47:28.012955Z","steps":["trace[392461041] 'read index received' (duration: 163.549493ms)","trace[392461041] 'applied index is now lower than readState.Index' (duration: 110.602µs)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:47:28.013077Z","caller":"traceutil/trace.go:171","msg":"trace[1723478467] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"204.146277ms","start":"2026-04-07T05:47:27.808922Z","end":"2026-04-07T05:47:28.013068Z","steps":["trace[1723478467] 'process raft request' (duration: 203.913743ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:28.013243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.611869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:47:28.013378Z","caller":"traceutil/trace.go:171","msg":"trace[2062671318] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1344; }","duration":"106.827672ms","start":"2026-04-07T05:47:27.906532Z","end":"2026-04-07T05:47:28.013359Z","steps":["trace[2062671318] 'agreement among raft nodes before linearized reading' (duration: 106.560637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:28.013184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.880028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-07T05:47:28.013675Z","caller":"traceutil/trace.go:171","msg":"trace[1552815202] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1344; }","duration":"164.400777ms","start":"2026-04-07T05:47:27.849241Z","end":"2026-04-07T05:47:28.013642Z","steps":["trace[1552815202] 'agreement among raft nodes before linearized reading' (duration: 163.876479ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:30.5819Z","caller":"traceutil/trace.go:171","msg":"trace[178490963] transaction","detail":"{read_only:false; response_revision:1353; number_of_response:1; }","duration":"209.866777ms","start":"2026-04-07T05:47:30.372005Z","end":"2026-04-07T05:47:30.581871Z","steps":["trace[178490963] 'process raft request' (duration: 209.598783ms)"],"step_count":1} {"level":"info","ts":"2026-04-07T05:47:30.59034Z","caller":"traceutil/trace.go:171","msg":"trace[1962227093] linearizableReadLoop","detail":"{readStateIndex:1413; appliedIndex:1411; }","duration":"169.00698ms","start":"2026-04-07T05:47:30.421305Z","end":"2026-04-07T05:47:30.590312Z","steps":["trace[1962227093] 'read index received' (duration: 160.474521ms)","trace[1962227093] 'applied index is now lower than readState.Index' (duration: 8.531639ms)"],"step_count":2} {"level":"info","ts":"2026-04-07T05:47:30.590465Z","caller":"traceutil/trace.go:171","msg":"trace[1629122904] transaction","detail":"{read_only:false; response_revision:1354; number_of_response:1; }","duration":"181.665807ms","start":"2026-04-07T05:47:30.408757Z","end":"2026-04-07T05:47:30.590422Z","steps":["trace[1629122904] 'process raft request' (duration: 181.458124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:30.590673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.146292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-07T05:47:30.590744Z","caller":"traceutil/trace.go:171","msg":"trace[1127589801] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1354; }","duration":"169.254134ms","start":"2026-04-07T05:47:30.42148Z","end":"2026-04-07T05:47:30.590734Z","steps":["trace[1127589801] 'agreement among raft nodes before linearized reading' (duration: 169.00049ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:30.590773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.467357ms","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-07T05:47:30.590888Z","caller":"traceutil/trace.go:171","msg":"trace[105068203] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1354; }","duration":"169.574719ms","start":"2026-04-07T05:47:30.421298Z","end":"2026-04-07T05:47:30.590872Z","steps":["trace[105068203] 'agreement among raft nodes before linearized reading' (duration: 169.148772ms)"],"step_count":1} {"level":"warn","ts":"2026-04-07T05:47:30.590674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.976082ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-07T05:47:30.591115Z","caller":"traceutil/trace.go:171","msg":"trace[240455842] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1354; }","duration":"163.45242ms","start":"2026-04-07T05:47:30.427636Z","end":"2026-04-07T05:47:30.591088Z","steps":["trace[240455842] 'agreement among raft nodes before linearized reading' (duration: 162.954352ms)"],"step_count":1}