{"level":"warn","ts":"2026-06-30T08:23:00.721181Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T08:23:00.721266Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.4: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.4:2380","--initial-cluster=instance=https://199.204.45.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.4: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-06-30T08:23:00.721326Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-30T08:23:00.721338Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-30T08:23:00.721354Z","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-06-30T08:23:00.72202Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"]} {"level":"info","ts":"2026-06-30T08:23:00.72211Z","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.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.4: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-06-30T08:23:00.72654Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.254009ms"} {"level":"info","ts":"2026-06-30T08:23:00.73335Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"66f7b57d56ad567d","cluster-id":"ec267dcaac715770"} {"level":"info","ts":"2026-06-30T08:23:00.73344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=()"} {"level":"info","ts":"2026-06-30T08:23:00.733466Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 0"} {"level":"info","ts":"2026-06-30T08:23:00.73348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 66f7b57d56ad567d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-30T08:23:00.73349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became follower at term 1"} {"level":"info","ts":"2026-06-30T08:23:00.733532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"warn","ts":"2026-06-30T08:23:00.740061Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-30T08:23:00.741296Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-30T08:23:00.7427Z","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-06-30T08:23:00.745553Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"66f7b57d56ad567d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-30T08:23:00.745753Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"66f7b57d56ad567d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-30T08:23:00.745936Z","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-06-30T08:23:00.746025Z","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-06-30T08:23:00.746036Z","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-06-30T08:23:00.748333Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d switched to configuration voters=(7419598461045921405)"} {"level":"info","ts":"2026-06-30T08:23:00.74852Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","added-peer-id":"66f7b57d56ad567d","added-peer-peer-urls":["https://199.204.45.4:2380"]} {"level":"info","ts":"2026-06-30T08:23:00.751362Z","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-06-30T08:23:00.751444Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-30T08:23:00.751498Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.4:2380"} {"level":"info","ts":"2026-06-30T08:23:00.751672Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"66f7b57d56ad567d","initial-advertise-peer-urls":["https://199.204.45.4:2380"],"listen-peer-urls":["https://199.204.45.4:2380"],"advertise-client-urls":["https://199.204.45.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-30T08:23:00.751715Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-30T08:23:00.934499Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d is starting a new election at term 1"} {"level":"info","ts":"2026-06-30T08:23:00.934573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-30T08:23:00.934596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgPreVoteResp from 66f7b57d56ad567d at term 1"} {"level":"info","ts":"2026-06-30T08:23:00.934627Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became candidate at term 2"} {"level":"info","ts":"2026-06-30T08:23:00.934645Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d received MsgVoteResp from 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-30T08:23:00.934699Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"66f7b57d56ad567d became leader at term 2"} {"level":"info","ts":"2026-06-30T08:23:00.934719Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 66f7b57d56ad567d elected leader 66f7b57d56ad567d at term 2"} {"level":"info","ts":"2026-06-30T08:23:01.162699Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:23:01.16281Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T08:23:01.162591Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"66f7b57d56ad567d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.4:2379]}","request-path":"/0/members/66f7b57d56ad567d/attributes","cluster-id":"ec267dcaac715770","publish-timeout":"7s"} {"level":"info","ts":"2026-06-30T08:23:01.16278Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-30T08:23:01.163279Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-30T08:23:01.163395Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-30T08:23:01.167754Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"ec267dcaac715770","local-member-id":"66f7b57d56ad567d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:23:01.167837Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:23:01.167865Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-30T08:23:01.167906Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-30T08:23:01.168718Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.4:2379"} {"level":"info","ts":"2026-06-30T08:23:06.471945Z","caller":"traceutil/trace.go:171","msg":"trace[1872912573] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"308.027787ms","start":"2026-06-30T08:23:06.163859Z","end":"2026-06-30T08:23:06.471887Z","steps":["trace[1872912573] 'process raft request' (duration: 297.116166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:06.472112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.941179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4015"} {"level":"info","ts":"2026-06-30T08:23:06.472181Z","caller":"traceutil/trace.go:171","msg":"trace[838846977] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:223; }","duration":"377.055523ms","start":"2026-06-30T08:23:06.09511Z","end":"2026-06-30T08:23:06.472166Z","steps":["trace[838846977] 'agreement among raft nodes before linearized reading' (duration: 376.930369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:06.472224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:06.095094Z","time spent":"377.117294ms","remote":"127.0.0.1:43748","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4038,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-06-30T08:23:06.471911Z","caller":"traceutil/trace.go:171","msg":"trace[127300943] linearizableReadLoop","detail":"{readStateIndex:230; appliedIndex:229; }","duration":"307.087018ms","start":"2026-06-30T08:23:06.164746Z","end":"2026-06-30T08:23:06.471833Z","steps":["trace[127300943] 'read index received' (duration: 296.244249ms)","trace[127300943] 'applied index is now lower than readState.Index' (duration: 10.841609ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:23:06.472535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:06.163833Z","time spent":"308.236334ms","remote":"127.0.0.1:43748","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-06-30T08:23:06.472667Z","caller":"traceutil/trace.go:171","msg":"trace[1236560493] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"306.1468ms","start":"2026-06-30T08:23:06.166504Z","end":"2026-06-30T08:23:06.47265Z","steps":["trace[1236560493] 'process raft request' (duration: 305.86473ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:06.472754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:06.166467Z","time spent":"306.247373ms","remote":"127.0.0.1:43654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":592,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:23:06.472784Z","caller":"traceutil/trace.go:171","msg":"trace[1215234365] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"297.404737ms","start":"2026-06-30T08:23:06.175363Z","end":"2026-06-30T08:23:06.472768Z","steps":["trace[1215234365] 'process raft request' (duration: 297.242022ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:06.472819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.752885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-30T08:23:06.472811Z","caller":"traceutil/trace.go:171","msg":"trace[319498746] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"303.847008ms","start":"2026-06-30T08:23:06.168933Z","end":"2026-06-30T08:23:06.47278Z","steps":["trace[319498746] 'process raft request' (duration: 303.529587ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.472877Z","caller":"traceutil/trace.go:171","msg":"trace[1538618484] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"297.19517ms","start":"2026-06-30T08:23:06.175647Z","end":"2026-06-30T08:23:06.472843Z","steps":["trace[1538618484] 'process raft request' (duration: 297.055705ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.472888Z","caller":"traceutil/trace.go:171","msg":"trace[624567743] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:229; }","duration":"304.850018ms","start":"2026-06-30T08:23:06.168021Z","end":"2026-06-30T08:23:06.472871Z","steps":["trace[624567743] 'agreement among raft nodes before linearized reading' (duration: 304.724245ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.472879Z","caller":"traceutil/trace.go:171","msg":"trace[1534396195] transaction","detail":"{read_only:false; number_of_response:0; response_revision:225; }","duration":"298.251323ms","start":"2026-06-30T08:23:06.174601Z","end":"2026-06-30T08:23:06.472853Z","steps":["trace[1534396195] 'process raft request' (duration: 297.911102ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.472881Z","caller":"traceutil/trace.go:171","msg":"trace[68358690] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"297.332774ms","start":"2026-06-30T08:23:06.1755Z","end":"2026-06-30T08:23:06.472833Z","steps":["trace[68358690] 'process raft request' (duration: 297.151989ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:06.472935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:06.16801Z","time spent":"304.911711ms","remote":"127.0.0.1:43972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":687,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-06-30T08:23:06.472943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:06.168921Z","time spent":"303.965631ms","remote":"127.0.0.1:43782","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:23:06.473117Z","caller":"traceutil/trace.go:171","msg":"trace[1716014712] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"297.81621ms","start":"2026-06-30T08:23:06.175287Z","end":"2026-06-30T08:23:06.473104Z","steps":["trace[1716014712] 'process raft request' (duration: 297.264223ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.672326Z","caller":"traceutil/trace.go:171","msg":"trace[1213896114] transaction","detail":"{read_only:false; response_revision:230; number_of_response:1; }","duration":"194.927936ms","start":"2026-06-30T08:23:06.47737Z","end":"2026-06-30T08:23:06.672298Z","steps":["trace[1213896114] 'process raft request' (duration: 131.575588ms)","trace[1213896114] 'compare' (duration: 63.238424ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:23:06.673091Z","caller":"traceutil/trace.go:171","msg":"trace[871582270] transaction","detail":"{read_only:false; response_revision:231; number_of_response:1; }","duration":"194.814803ms","start":"2026-06-30T08:23:06.478243Z","end":"2026-06-30T08:23:06.673058Z","steps":["trace[871582270] 'process raft request' (duration: 194.670229ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.673212Z","caller":"traceutil/trace.go:171","msg":"trace[204700112] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"187.010659ms","start":"2026-06-30T08:23:06.486182Z","end":"2026-06-30T08:23:06.673192Z","steps":["trace[204700112] 'process raft request' (duration: 186.843904ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.673133Z","caller":"traceutil/trace.go:171","msg":"trace[1182813797] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"188.676681ms","start":"2026-06-30T08:23:06.484427Z","end":"2026-06-30T08:23:06.673103Z","steps":["trace[1182813797] 'process raft request' (duration: 188.548857ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.996475Z","caller":"traceutil/trace.go:171","msg":"trace[826526723] transaction","detail":"{read_only:false; response_revision:240; number_of_response:1; }","duration":"257.564853ms","start":"2026-06-30T08:23:06.738885Z","end":"2026-06-30T08:23:06.99645Z","steps":["trace[826526723] 'process raft request' (duration: 257.519722ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:06.996538Z","caller":"traceutil/trace.go:171","msg":"trace[471277737] linearizableReadLoop","detail":"{readStateIndex:246; appliedIndex:245; }","duration":"258.516273ms","start":"2026-06-30T08:23:06.737987Z","end":"2026-06-30T08:23:06.996503Z","steps":["trace[471277737] 'read index received' (duration: 237.482136ms)","trace[471277737] 'applied index is now lower than readState.Index' (duration: 21.030776ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:23:06.996666Z","caller":"traceutil/trace.go:171","msg":"trace[121221457] transaction","detail":"{read_only:false; response_revision:238; number_of_response:1; }","duration":"261.807175ms","start":"2026-06-30T08:23:06.734845Z","end":"2026-06-30T08:23:06.996652Z","steps":["trace[121221457] 'process raft request' (duration: 240.613103ms)","trace[121221457] 'compare' (duration: 20.79368ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:23:06.996743Z","caller":"traceutil/trace.go:171","msg":"trace[526048197] transaction","detail":"{read_only:false; response_revision:239; number_of_response:1; }","duration":"258.43114ms","start":"2026-06-30T08:23:06.738301Z","end":"2026-06-30T08:23:06.996732Z","steps":["trace[526048197] 'process raft request' (duration: 258.058348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:06.996939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.930855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-30T08:23:06.996985Z","caller":"traceutil/trace.go:171","msg":"trace[1709678389] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:240; }","duration":"259.020948ms","start":"2026-06-30T08:23:06.737952Z","end":"2026-06-30T08:23:06.996973Z","steps":["trace[1709678389] 'agreement among raft nodes before linearized reading' (duration: 258.897884ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:06.997143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.011728ms","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-06-30T08:23:06.997179Z","caller":"traceutil/trace.go:171","msg":"trace[790797869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:240; }","duration":"259.07692ms","start":"2026-06-30T08:23:06.738093Z","end":"2026-06-30T08:23:06.99717Z","steps":["trace[790797869] 'agreement among raft nodes before linearized reading' (duration: 259.020528ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:11.812151Z","caller":"traceutil/trace.go:171","msg":"trace[2087743372] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"100.636982ms","start":"2026-06-30T08:23:11.711497Z","end":"2026-06-30T08:23:11.812134Z","steps":["trace[2087743372] 'process raft request' (duration: 100.422086ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:33.13696Z","caller":"traceutil/trace.go:171","msg":"trace[1326801190] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"129.705923ms","start":"2026-06-30T08:23:33.00722Z","end":"2026-06-30T08:23:33.136926Z","steps":["trace[1326801190] 'process raft request' (duration: 129.469197ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:38.102279Z","caller":"traceutil/trace.go:171","msg":"trace[1634877692] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"111.455854ms","start":"2026-06-30T08:23:37.990794Z","end":"2026-06-30T08:23:38.10225Z","steps":["trace[1634877692] 'process raft request' (duration: 111.238539ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:38.102441Z","caller":"traceutil/trace.go:171","msg":"trace[1204848799] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"102.234486ms","start":"2026-06-30T08:23:38.000175Z","end":"2026-06-30T08:23:38.102409Z","steps":["trace[1204848799] 'process raft request' (duration: 102.028261ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:38.102688Z","caller":"traceutil/trace.go:171","msg":"trace[1947267371] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"109.276174ms","start":"2026-06-30T08:23:37.99338Z","end":"2026-06-30T08:23:38.102656Z","steps":["trace[1947267371] 'process raft request' (duration: 108.755623ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:38.851563Z","caller":"traceutil/trace.go:171","msg":"trace[981399819] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"640.761372ms","start":"2026-06-30T08:23:38.210771Z","end":"2026-06-30T08:23:38.851532Z","steps":["trace[981399819] 'process raft request' (duration: 632.342044ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:38.851988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:38.210758Z","time spent":"640.899165ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29452,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:23:38.865584Z","caller":"traceutil/trace.go:171","msg":"trace[881199868] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"649.301643ms","start":"2026-06-30T08:23:38.216262Z","end":"2026-06-30T08:23:38.865564Z","steps":["trace[881199868] 'process raft request' (duration: 649.15722ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:38.865948Z","caller":"traceutil/trace.go:171","msg":"trace[232788895] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"601.659677ms","start":"2026-06-30T08:23:38.264236Z","end":"2026-06-30T08:23:38.865895Z","steps":["trace[232788895] 'process raft request' (duration: 601.299669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:38.866084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:38.216253Z","time spent":"649.422335ms","remote":"127.0.0.1:43626","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-06-30T08:23:38.866107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:38.264208Z","time spent":"601.844111ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17062,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-30T08:23:38.866736Z","caller":"traceutil/trace.go:171","msg":"trace[1310877833] linearizableReadLoop","detail":"{readStateIndex:540; appliedIndex:536; }","duration":"214.707688ms","start":"2026-06-30T08:23:38.652006Z","end":"2026-06-30T08:23:38.866714Z","steps":["trace[1310877833] 'read index received' (duration: 191.121011ms)","trace[1310877833] 'applied index is now lower than readState.Index' (duration: 23.585827ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:23:38.866778Z","caller":"traceutil/trace.go:171","msg":"trace[1952010305] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"600.254196ms","start":"2026-06-30T08:23:38.266499Z","end":"2026-06-30T08:23:38.866753Z","steps":["trace[1952010305] 'process raft request' (duration: 599.404497ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:38.86686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.837541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:23:38.866903Z","caller":"traceutil/trace.go:171","msg":"trace[1791677627] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:520; }","duration":"214.915463ms","start":"2026-06-30T08:23:38.651974Z","end":"2026-06-30T08:23:38.866889Z","steps":["trace[1791677627] 'agreement among raft nodes before linearized reading' (duration: 214.804961ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:38.866955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:38.266457Z","time spent":"600.40696ms","remote":"127.0.0.1:43626","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:23:45.70709Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312383165792826,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:23:45.734037Z","caller":"traceutil/trace.go:171","msg":"trace[1910552587] linearizableReadLoop","detail":"{readStateIndex:617; appliedIndex:616; }","duration":"527.368491ms","start":"2026-06-30T08:23:45.206629Z","end":"2026-06-30T08:23:45.733997Z","steps":["trace[1910552587] 'read index received' (duration: 517.929123ms)","trace[1910552587] 'applied index is now lower than readState.Index' (duration: 9.438128ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:23:45.734256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.611905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-tf558\" ","response":"range_response_count:1 size:16957"} {"level":"info","ts":"2026-06-30T08:23:45.734289Z","caller":"traceutil/trace.go:171","msg":"trace[187536137] range","detail":"{range_begin:/registry/pods/kube-system/cilium-tf558; range_end:; response_count:1; response_revision:595; }","duration":"527.671267ms","start":"2026-06-30T08:23:45.206603Z","end":"2026-06-30T08:23:45.734274Z","steps":["trace[187536137] 'agreement among raft nodes before linearized reading' (duration: 527.550505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:45.734328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.206587Z","time spent":"527.734778ms","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16980,"request content":"key:\"/registry/pods/kube-system/cilium-tf558\" "} {"level":"warn","ts":"2026-06-30T08:23:45.734414Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.840514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:476"} {"level":"info","ts":"2026-06-30T08:23:45.734372Z","caller":"traceutil/trace.go:171","msg":"trace[693147079] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"570.33685ms","start":"2026-06-30T08:23:45.163985Z","end":"2026-06-30T08:23:45.734322Z","steps":["trace[693147079] 'process raft request' (duration: 561.638758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:45.734437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"478.893236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:23:45.73449Z","caller":"traceutil/trace.go:171","msg":"trace[454474300] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:595; }","duration":"478.979367ms","start":"2026-06-30T08:23:45.255487Z","end":"2026-06-30T08:23:45.734466Z","steps":["trace[454474300] 'agreement among raft nodes before linearized reading' (duration: 478.832754ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:45.73453Z","caller":"traceutil/trace.go:171","msg":"trace[794750944] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:595; }","duration":"479.010688ms","start":"2026-06-30T08:23:45.255486Z","end":"2026-06-30T08:23:45.734497Z","steps":["trace[794750944] 'agreement among raft nodes before linearized reading' (duration: 478.842534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:45.73451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.089376ms","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-06-30T08:23:45.73457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.255465Z","time spent":"479.09011ms","remote":"127.0.0.1:43844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-30T08:23:45.734589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.163965Z","time spent":"570.533935ms","remote":"127.0.0.1:43676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:23:45.734605Z","caller":"traceutil/trace.go:171","msg":"trace[2146923820] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"486.30941ms","start":"2026-06-30T08:23:45.248279Z","end":"2026-06-30T08:23:45.734588Z","steps":["trace[2146923820] 'agreement among raft nodes before linearized reading' (duration: 485.997034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:45.734738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.248258Z","time spent":"486.474523ms","remote":"127.0.0.1:43844","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-06-30T08:23:45.734544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.25546Z","time spent":"479.077699ms","remote":"127.0.0.1:43844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":499,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-30T08:23:46.376093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"565.313196ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:23:46.37621Z","caller":"traceutil/trace.go:171","msg":"trace[1559596267] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"638.153291ms","start":"2026-06-30T08:23:45.738033Z","end":"2026-06-30T08:23:46.376187Z","steps":["trace[1559596267] 'process raft request' (duration: 72.537929ms)","trace[1559596267] 'compare' (duration: 565.195704ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:23:46.376316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.738015Z","time spent":"638.237222ms","remote":"127.0.0.1:43844","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-06-30T08:23:46.409065Z","caller":"traceutil/trace.go:171","msg":"trace[1139904020] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"670.87109ms","start":"2026-06-30T08:23:45.738137Z","end":"2026-06-30T08:23:46.409008Z","steps":["trace[1139904020] 'process raft request' (duration: 670.616185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:46.409285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"646.481149ms","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-06-30T08:23:46.409421Z","caller":"traceutil/trace.go:171","msg":"trace[2040392161] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"658.424788ms","start":"2026-06-30T08:23:45.750954Z","end":"2026-06-30T08:23:46.409379Z","steps":["trace[2040392161] 'process raft request' (duration: 658.00122ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:46.409487Z","caller":"traceutil/trace.go:171","msg":"trace[1361623634] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:600; }","duration":"646.53441ms","start":"2026-06-30T08:23:45.762786Z","end":"2026-06-30T08:23:46.409321Z","steps":["trace[1361623634] 'agreement among raft nodes before linearized reading' (duration: 646.343756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:46.409544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.762757Z","time spent":"646.772395ms","remote":"127.0.0.1:43844","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-06-30T08:23:46.409595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.750932Z","time spent":"658.567012ms","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:23:46.409627Z","caller":"traceutil/trace.go:171","msg":"trace[1874380423] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"626.5263ms","start":"2026-06-30T08:23:45.783057Z","end":"2026-06-30T08:23:46.409583Z","steps":["trace[1874380423] 'process raft request' (duration: 625.99061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:46.409396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.738119Z","time spent":"671.122414ms","remote":"127.0.0.1:43844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:23:46.4091Z","caller":"traceutil/trace.go:171","msg":"trace[911788987] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:617; }","duration":"646.292095ms","start":"2026-06-30T08:23:45.762791Z","end":"2026-06-30T08:23:46.409083Z","steps":["trace[911788987] 'read index received' (duration: 47.74402ms)","trace[911788987] 'applied index is now lower than readState.Index' (duration: 598.547215ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:23:46.409822Z","caller":"traceutil/trace.go:171","msg":"trace[203297491] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"671.519323ms","start":"2026-06-30T08:23:45.738291Z","end":"2026-06-30T08:23:46.40981Z","steps":["trace[203297491] 'process raft request' (duration: 670.576374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:46.410104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.738256Z","time spent":"671.768147ms","remote":"127.0.0.1:43844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:23:46.409796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:45.783026Z","time spent":"626.701644ms","remote":"127.0.0.1:43822","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:23:47.7676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230027032s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-30T08:23:47.767718Z","caller":"traceutil/trace.go:171","msg":"trace[1913497761] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.313948151s","start":"2026-06-30T08:23:46.453739Z","end":"2026-06-30T08:23:47.767687Z","steps":["trace[1913497761] 'process raft request' (duration: 83.734106ms)","trace[1913497761] 'compare' (duration: 1.229594663s)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:23:47.767857Z","caller":"traceutil/trace.go:171","msg":"trace[1984495051] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"378.322239ms","start":"2026-06-30T08:23:47.389513Z","end":"2026-06-30T08:23:47.767835Z","steps":["trace[1984495051] 'process raft request' (duration: 378.184637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:47.767878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:46.453727Z","time spent":"1.314059704s","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2735,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-30T08:23:47.767944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:47.389487Z","time spent":"378.417692ms","remote":"127.0.0.1:43844","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-30T08:23:47.768132Z","caller":"traceutil/trace.go:171","msg":"trace[2070091690] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:623; }","duration":"1.116490044s","start":"2026-06-30T08:23:46.651632Z","end":"2026-06-30T08:23:47.768122Z","steps":["trace[2070091690] 'read index received' (duration: 45.501µs)","trace[2070091690] 'applied index is now lower than readState.Index' (duration: 1.116443423s)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:23:47.768192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116566486s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:23:47.768217Z","caller":"traceutil/trace.go:171","msg":"trace[1413310237] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"1.116630107s","start":"2026-06-30T08:23:46.651578Z","end":"2026-06-30T08:23:47.768209Z","steps":["trace[1413310237] 'agreement among raft nodes before linearized reading' (duration: 1.116585106s)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:47.768243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:23:46.651558Z","time spent":"1.116679888s","remote":"127.0.0.1:43602","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-06-30T08:23:49.673903Z","caller":"traceutil/trace.go:171","msg":"trace[870667543] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"296.686003ms","start":"2026-06-30T08:23:49.377188Z","end":"2026-06-30T08:23:49.673874Z","steps":["trace[870667543] 'process raft request' (duration: 296.544209ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:49.680285Z","caller":"traceutil/trace.go:171","msg":"trace[1325600919] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"102.700713ms","start":"2026-06-30T08:23:49.57757Z","end":"2026-06-30T08:23:49.68027Z","steps":["trace[1325600919] 'process raft request' (duration: 102.50467ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:23:52.493217Z","caller":"traceutil/trace.go:171","msg":"trace[1222299224] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"100.294582ms","start":"2026-06-30T08:23:52.392903Z","end":"2026-06-30T08:23:52.493198Z","steps":["trace[1222299224] 'read index received' (duration: 100.093269ms)","trace[1222299224] 'applied index is now lower than readState.Index' (duration: 200.383µs)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:23:52.493347Z","caller":"traceutil/trace.go:171","msg":"trace[886167987] transaction","detail":"{read_only:false; response_revision:671; number_of_response:1; }","duration":"111.656147ms","start":"2026-06-30T08:23:52.381664Z","end":"2026-06-30T08:23:52.49332Z","steps":["trace[886167987] 'process raft request' (duration: 111.415782ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:23:52.493863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.946346ms","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-06-30T08:23:52.493911Z","caller":"traceutil/trace.go:171","msg":"trace[205894672] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:671; }","duration":"101.038478ms","start":"2026-06-30T08:23:52.39286Z","end":"2026-06-30T08:23:52.493899Z","steps":["trace[205894672] 'agreement among raft nodes before linearized reading' (duration: 100.455976ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:02.817083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6232312383165793133,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-30T08:24:02.975655Z","caller":"traceutil/trace.go:171","msg":"trace[193904261] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"674.707944ms","start":"2026-06-30T08:24:02.300923Z","end":"2026-06-30T08:24:02.975631Z","steps":["trace[193904261] 'process raft request' (duration: 674.567721ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:24:02.975721Z","caller":"traceutil/trace.go:171","msg":"trace[1166244013] linearizableReadLoop","detail":"{readStateIndex:783; appliedIndex:783; }","duration":"658.659164ms","start":"2026-06-30T08:24:02.317038Z","end":"2026-06-30T08:24:02.975697Z","steps":["trace[1166244013] 'read index received' (duration: 658.651634ms)","trace[1166244013] 'applied index is now lower than readState.Index' (duration: 5.96µs)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:24:02.975938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.922564ms","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-06-30T08:24:02.975977Z","caller":"traceutil/trace.go:171","msg":"trace[507182380] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:757; }","duration":"436.006735ms","start":"2026-06-30T08:24:02.539961Z","end":"2026-06-30T08:24:02.975968Z","steps":["trace[507182380] 'agreement among raft nodes before linearized reading' (duration: 435.841842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:02.976009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:24:02.539945Z","time spent":"436.056847ms","remote":"127.0.0.1:43844","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-06-30T08:24:02.976209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:24:02.3009Z","time spent":"674.829735ms","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4023,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-30T08:24:02.976288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"659.249684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-30T08:24:02.976399Z","caller":"traceutil/trace.go:171","msg":"trace[1080160348] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:757; }","duration":"659.404297ms","start":"2026-06-30T08:24:02.316984Z","end":"2026-06-30T08:24:02.976389Z","steps":["trace[1080160348] 'agreement among raft nodes before linearized reading' (duration: 659.211113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:02.976433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:24:02.316964Z","time spent":"659.459167ms","remote":"127.0.0.1:43936","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-30T08:24:02.976633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.256263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-30T08:24:02.97663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.387295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-30T08:24:02.976684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.5709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-30T08:24:02.976735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.520738ms","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-06-30T08:24:02.976727Z","caller":"traceutil/trace.go:171","msg":"trace[911783830] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:757; }","duration":"205.541038ms","start":"2026-06-30T08:24:02.771163Z","end":"2026-06-30T08:24:02.976704Z","steps":["trace[911783830] 'agreement among raft nodes before linearized reading' (duration: 205.346385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:02.976798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.498488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-30T08:24:02.97667Z","caller":"traceutil/trace.go:171","msg":"trace[1394121024] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:757; }","duration":"430.325944ms","start":"2026-06-30T08:24:02.546333Z","end":"2026-06-30T08:24:02.976659Z","steps":["trace[1394121024] 'agreement among raft nodes before linearized reading' (duration: 430.236053ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:24:02.976825Z","caller":"traceutil/trace.go:171","msg":"trace[1138886821] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:757; }","duration":"325.556078ms","start":"2026-06-30T08:24:02.65126Z","end":"2026-06-30T08:24:02.976816Z","steps":["trace[1138886821] 'agreement among raft nodes before linearized reading' (duration: 325.517507ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:24:02.976751Z","caller":"traceutil/trace.go:171","msg":"trace[360144022] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:757; }","duration":"429.678132ms","start":"2026-06-30T08:24:02.547055Z","end":"2026-06-30T08:24:02.976733Z","steps":["trace[360144022] 'agreement among raft nodes before linearized reading' (duration: 429.459348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:02.976855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:24:02.651239Z","time spent":"325.60914ms","remote":"127.0.0.1:43602","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-06-30T08:24:02.976853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:24:02.546317Z","time spent":"430.521398ms","remote":"127.0.0.1:43844","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-06-30T08:24:02.976878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:24:02.547044Z","time spent":"429.819734ms","remote":"127.0.0.1:43844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-30T08:24:02.976761Z","caller":"traceutil/trace.go:171","msg":"trace[1659894198] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:757; }","duration":"435.587638ms","start":"2026-06-30T08:24:02.541167Z","end":"2026-06-30T08:24:02.976754Z","steps":["trace[1659894198] 'agreement among raft nodes before linearized reading' (duration: 435.522087ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:02.97694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-30T08:24:02.541146Z","time spent":"435.784702ms","remote":"127.0.0.1:43844","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-06-30T08:24:14.112045Z","caller":"traceutil/trace.go:171","msg":"trace[1298760764] transaction","detail":"{read_only:false; response_revision:905; number_of_response:1; }","duration":"131.863019ms","start":"2026-06-30T08:24:13.979891Z","end":"2026-06-30T08:24:14.111754Z","steps":["trace[1298760764] 'process raft request' (duration: 62.025807ms)","trace[1298760764] 'compare' (duration: 69.709499ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:24:31.331553Z","caller":"traceutil/trace.go:171","msg":"trace[1781415898] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"127.783827ms","start":"2026-06-30T08:24:31.203735Z","end":"2026-06-30T08:24:31.331519Z","steps":["trace[1781415898] 'process raft request' (duration: 127.556764ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:24:31.356443Z","caller":"traceutil/trace.go:171","msg":"trace[1351256664] linearizableReadLoop","detail":"{readStateIndex:1012; appliedIndex:1010; }","duration":"146.421761ms","start":"2026-06-30T08:24:31.209998Z","end":"2026-06-30T08:24:31.35642Z","steps":["trace[1351256664] 'read index received' (duration: 121.358493ms)","trace[1351256664] 'applied index is now lower than readState.Index' (duration: 25.062268ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:24:31.356532Z","caller":"traceutil/trace.go:171","msg":"trace[1132482895] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"152.063614ms","start":"2026-06-30T08:24:31.204432Z","end":"2026-06-30T08:24:31.356495Z","steps":["trace[1132482895] 'process raft request' (duration: 151.857481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:31.356674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.664564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-30T08:24:31.356731Z","caller":"traceutil/trace.go:171","msg":"trace[1520273868] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:978; }","duration":"146.768706ms","start":"2026-06-30T08:24:31.209937Z","end":"2026-06-30T08:24:31.356706Z","steps":["trace[1520273868] 'agreement among raft nodes before linearized reading' (duration: 146.616734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:31.356947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.246909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-30T08:24:31.357269Z","caller":"traceutil/trace.go:171","msg":"trace[415390661] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:978; }","duration":"142.616194ms","start":"2026-06-30T08:24:31.214628Z","end":"2026-06-30T08:24:31.357245Z","steps":["trace[415390661] 'agreement among raft nodes before linearized reading' (duration: 142.050025ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:24:34.908621Z","caller":"traceutil/trace.go:171","msg":"trace[1534503286] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"197.182612ms","start":"2026-06-30T08:24:34.71141Z","end":"2026-06-30T08:24:34.908593Z","steps":["trace[1534503286] 'process raft request' (duration: 197.02094ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:24:52.026784Z","caller":"traceutil/trace.go:171","msg":"trace[1164461806] linearizableReadLoop","detail":"{readStateIndex:1089; appliedIndex:1088; }","duration":"276.154525ms","start":"2026-06-30T08:24:51.750607Z","end":"2026-06-30T08:24:52.026762Z","steps":["trace[1164461806] 'read index received' (duration: 259.701891ms)","trace[1164461806] 'applied index is now lower than readState.Index' (duration: 16.451594ms)"],"step_count":2} {"level":"info","ts":"2026-06-30T08:24:52.02685Z","caller":"traceutil/trace.go:171","msg":"trace[127353083] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"280.25664ms","start":"2026-06-30T08:24:51.746553Z","end":"2026-06-30T08:24:52.02681Z","steps":["trace[127353083] 'process raft request' (duration: 263.693804ms)","trace[127353083] 'compare' (duration: 16.424054ms)"],"step_count":2} {"level":"warn","ts":"2026-06-30T08:24:52.026956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.333498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-30T08:24:52.02702Z","caller":"traceutil/trace.go:171","msg":"trace[559067297] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1050; }","duration":"276.413949ms","start":"2026-06-30T08:24:51.750591Z","end":"2026-06-30T08:24:52.027004Z","steps":["trace[559067297] 'agreement among raft nodes before linearized reading' (duration: 276.245747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-30T08:24:52.027029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.765719ms","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-06-30T08:24:52.027031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.374378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-30T08:24:52.027073Z","caller":"traceutil/trace.go:171","msg":"trace[72681202] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1050; }","duration":"152.867131ms","start":"2026-06-30T08:24:51.874197Z","end":"2026-06-30T08:24:52.027065Z","steps":["trace[72681202] 'agreement among raft nodes before linearized reading' (duration: 152.679719ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:24:52.02711Z","caller":"traceutil/trace.go:171","msg":"trace[1504123868] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1050; }","duration":"150.469849ms","start":"2026-06-30T08:24:51.876624Z","end":"2026-06-30T08:24:52.027094Z","steps":["trace[1504123868] 'agreement among raft nodes before linearized reading' (duration: 150.313838ms)"],"step_count":1} {"level":"info","ts":"2026-06-30T08:25:06.178986Z","caller":"traceutil/trace.go:171","msg":"trace[390490633] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"109.103511ms","start":"2026-06-30T08:25:06.069857Z","end":"2026-06-30T08:25:06.17896Z","steps":["trace[390490633] 'process raft request' (duration: 108.937329ms)"],"step_count":1}