{"level":"warn","ts":"2026-05-08T10:20:02.979182Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T10:20:02.979281Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.138:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.138:2380","--initial-cluster=instance=https://199.19.213.138:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.138:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.138:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-08T10:20:02.979363Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-08T10:20:02.979374Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.138:2380"]} {"level":"info","ts":"2026-05-08T10:20:02.979399Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T10:20:02.980273Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"]} {"level":"info","ts":"2026-05-08T10:20:02.980367Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.138:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-08T10:20:03.072024Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"88.703895ms"} {"level":"info","ts":"2026-05-08T10:20:03.195124Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"2062be27cfb43adb","cluster-id":"f353072e75ed4d57"} {"level":"info","ts":"2026-05-08T10:20:03.195248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=()"} {"level":"info","ts":"2026-05-08T10:20:03.195411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 0"} {"level":"info","ts":"2026-05-08T10:20:03.195457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 2062be27cfb43adb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-08T10:20:03.195464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became follower at term 1"} {"level":"info","ts":"2026-05-08T10:20:03.195552Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"} {"level":"warn","ts":"2026-05-08T10:20:03.24768Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-08T10:20:03.274641Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-08T10:20:03.294452Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-08T10:20:03.328288Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"2062be27cfb43adb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-08T10:20:03.32855Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T10:20:03.328621Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T10:20:03.328631Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-08T10:20:03.328726Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"2062be27cfb43adb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-08T10:20:03.333215Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-08T10:20:03.333305Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.138:2380"} {"level":"info","ts":"2026-05-08T10:20:03.333344Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.138:2380"} {"level":"info","ts":"2026-05-08T10:20:03.333539Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"2062be27cfb43adb","initial-advertise-peer-urls":["https://199.19.213.138:2380"],"listen-peer-urls":["https://199.19.213.138:2380"],"advertise-client-urls":["https://199.19.213.138:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.138:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-08T10:20:03.3336Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-08T10:20:03.3405Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb switched to configuration voters=(2333636635129035483)"} {"level":"info","ts":"2026-05-08T10:20:03.340839Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","added-peer-id":"2062be27cfb43adb","added-peer-peer-urls":["https://199.19.213.138:2380"]} {"level":"info","ts":"2026-05-08T10:20:03.896123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb is starting a new election at term 1"} {"level":"info","ts":"2026-05-08T10:20:03.896177Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became pre-candidate at term 1"} {"level":"info","ts":"2026-05-08T10:20:03.896237Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgPreVoteResp from 2062be27cfb43adb at term 1"} {"level":"info","ts":"2026-05-08T10:20:03.896262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became candidate at term 2"} {"level":"info","ts":"2026-05-08T10:20:03.896277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb received MsgVoteResp from 2062be27cfb43adb at term 2"} {"level":"info","ts":"2026-05-08T10:20:03.896297Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"2062be27cfb43adb became leader at term 2"} {"level":"info","ts":"2026-05-08T10:20:03.896315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 2062be27cfb43adb elected leader 2062be27cfb43adb at term 2"} {"level":"info","ts":"2026-05-08T10:20:03.897382Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:20:03.897659Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"2062be27cfb43adb","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.138:2379]}","request-path":"/0/members/2062be27cfb43adb/attributes","cluster-id":"f353072e75ed4d57","publish-timeout":"7s"} {"level":"info","ts":"2026-05-08T10:20:03.897678Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:20:03.898199Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f353072e75ed4d57","local-member-id":"2062be27cfb43adb","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:20:03.898304Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:20:03.898333Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-08T10:20:03.898704Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-08T10:20:03.898738Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-08T10:20:03.901156Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-08T10:20:03.90852Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-08T10:20:03.916391Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.138:2379"} {"level":"info","ts":"2026-05-08T10:20:05.482799Z","caller":"traceutil/trace.go:171","msg":"trace[1284445370] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"371.957914ms","start":"2026-05-08T10:20:05.110815Z","end":"2026-05-08T10:20:05.482773Z","steps":["trace[1284445370] 'process raft request' (duration: 371.697801ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.483572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.110804Z","time spent":"372.082655ms","remote":"127.0.0.1:55508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":100,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:20:05.555567Z","caller":"traceutil/trace.go:171","msg":"trace[266952634] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"441.829131ms","start":"2026-05-08T10:20:05.113701Z","end":"2026-05-08T10:20:05.55553Z","steps":["trace[266952634] 'process raft request' (duration: 441.559108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.555676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.113695Z","time spent":"441.929052ms","remote":"127.0.0.1:55512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:20:05.555687Z","caller":"traceutil/trace.go:171","msg":"trace[1263945837] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"441.849922ms","start":"2026-05-08T10:20:05.11381Z","end":"2026-05-08T10:20:05.55566Z","steps":["trace[1263945837] 'read index received' (duration: 368.682196ms)","trace[1263945837] 'applied index is now lower than readState.Index' (duration: 73.166896ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:20:05.55586Z","caller":"traceutil/trace.go:171","msg":"trace[620724772] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"382.812173ms","start":"2026-05-08T10:20:05.173011Z","end":"2026-05-08T10:20:05.555824Z","steps":["trace[620724772] 'process raft request' (duration: 382.408488ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:20:05.555887Z","caller":"traceutil/trace.go:171","msg":"trace[54389103] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"382.62016ms","start":"2026-05-08T10:20:05.173252Z","end":"2026-05-08T10:20:05.555872Z","steps":["trace[54389103] 'process raft request' (duration: 382.327557ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:20:05.555884Z","caller":"traceutil/trace.go:171","msg":"trace[1388260574] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"382.623151ms","start":"2026-05-08T10:20:05.17319Z","end":"2026-05-08T10:20:05.555813Z","steps":["trace[1388260574] 'process raft request' (duration: 382.366838ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.555977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.173Z","time spent":"382.919144ms","remote":"127.0.0.1:55974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T10:20:05.555994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.173235Z","time spent":"382.686031ms","remote":"127.0.0.1:55974","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-05-08T10:20:05.556046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.173168Z","time spent":"382.799793ms","remote":"127.0.0.1:55974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T10:20:05.556091Z","caller":"traceutil/trace.go:171","msg":"trace[588429842] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"382.933724ms","start":"2026-05-08T10:20:05.173139Z","end":"2026-05-08T10:20:05.556073Z","steps":["trace[588429842] 'process raft request' (duration: 382.310066ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:20:05.556122Z","caller":"traceutil/trace.go:171","msg":"trace[1918219136] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"384.531793ms","start":"2026-05-08T10:20:05.171581Z","end":"2026-05-08T10:20:05.556112Z","steps":["trace[1918219136] 'process raft request' (duration: 383.802725ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.55616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.173124Z","time spent":"383.002314ms","remote":"127.0.0.1:55974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T10:20:05.556168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.171566Z","time spent":"384.587094ms","remote":"127.0.0.1:55898","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-08T10:20:05.556253Z","caller":"traceutil/trace.go:171","msg":"trace[151788881] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"383.102176ms","start":"2026-05-08T10:20:05.173135Z","end":"2026-05-08T10:20:05.556237Z","steps":["trace[151788881] 'process raft request' (duration: 382.395427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.556341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.17311Z","time spent":"383.181577ms","remote":"127.0.0.1:55974","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T10:20:05.556351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.52779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-08T10:20:05.556397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.484319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3171"} {"level":"info","ts":"2026-05-08T10:20:05.556418Z","caller":"traceutil/trace.go:171","msg":"trace[222761434] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"442.615421ms","start":"2026-05-08T10:20:05.113792Z","end":"2026-05-08T10:20:05.556408Z","steps":["trace[222761434] 'agreement among raft nodes before linearized reading' (duration: 442.477439ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:20:05.556432Z","caller":"traceutil/trace.go:171","msg":"trace[2122517917] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"442.53189ms","start":"2026-05-08T10:20:05.11389Z","end":"2026-05-08T10:20:05.556421Z","steps":["trace[2122517917] 'agreement among raft nodes before linearized reading' (duration: 442.414599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.556451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.113788Z","time spent":"442.657351ms","remote":"127.0.0.1:55854","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-08T10:20:05.556459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.113886Z","time spent":"442.56814ms","remote":"127.0.0.1:55620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":3194,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-05-08T10:20:05.556617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.644682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T10:20:05.55664Z","caller":"traceutil/trace.go:171","msg":"trace[406553548] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"372.659972ms","start":"2026-05-08T10:20:05.183972Z","end":"2026-05-08T10:20:05.556632Z","steps":["trace[406553548] 'process raft request' (duration: 371.62686ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:20:05.556643Z","caller":"traceutil/trace.go:171","msg":"trace[38581168] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"334.720293ms","start":"2026-05-08T10:20:05.221915Z","end":"2026-05-08T10:20:05.556635Z","steps":["trace[38581168] 'agreement among raft nodes before linearized reading' (duration: 334.683213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.556667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.221901Z","time spent":"334.760914ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-08T10:20:05.556676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.183958Z","time spent":"372.701383ms","remote":"127.0.0.1:55696","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-05-08T10:20:05.556717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.094281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.138\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T10:20:05.556771Z","caller":"traceutil/trace.go:171","msg":"trace[268989664] range","detail":"{range_begin:/registry/masterleases/199.19.213.138; range_end:; response_count:0; response_revision:11; }","duration":"386.172183ms","start":"2026-05-08T10:20:05.170584Z","end":"2026-05-08T10:20:05.556757Z","steps":["trace[268989664] 'agreement among raft nodes before linearized reading' (duration: 386.078012ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:20:05.556768Z","caller":"traceutil/trace.go:171","msg":"trace[1297041199] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"366.623601ms","start":"2026-05-08T10:20:05.190131Z","end":"2026-05-08T10:20:05.556755Z","steps":["trace[1297041199] 'process raft request' (duration: 365.500638ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.556791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.559469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-08T10:20:05.556812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.170549Z","time spent":"386.230523ms","remote":"127.0.0.1:55470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.138\" "} {"level":"info","ts":"2026-05-08T10:20:05.556821Z","caller":"traceutil/trace.go:171","msg":"trace[1478354138] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"387.63658ms","start":"2026-05-08T10:20:05.169177Z","end":"2026-05-08T10:20:05.556813Z","steps":["trace[1478354138] 'agreement among raft nodes before linearized reading' (duration: 387.596359ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.556847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.169147Z","time spent":"387.694401ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-08T10:20:05.556846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.190115Z","time spent":"366.691771ms","remote":"127.0.0.1:55620","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-08T10:20:05.556973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.821128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T10:20:05.557Z","caller":"traceutil/trace.go:171","msg":"trace[864463025] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"396.846769ms","start":"2026-05-08T10:20:05.160144Z","end":"2026-05-08T10:20:05.556991Z","steps":["trace[864463025] 'agreement among raft nodes before linearized reading' (duration: 396.809648ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.557024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.160113Z","time spent":"396.904819ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-08T10:20:05.557027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.155139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T10:20:05.557071Z","caller":"traceutil/trace.go:171","msg":"trace[317545051] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"384.220929ms","start":"2026-05-08T10:20:05.172837Z","end":"2026-05-08T10:20:05.557058Z","steps":["trace[317545051] 'agreement among raft nodes before linearized reading' (duration: 384.153269ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.557107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.172826Z","time spent":"384.27169ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-08T10:20:05.5573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.117962ms","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":"warn","ts":"2026-05-08T10:20:05.557265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.552587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-08T10:20:05.557347Z","caller":"traceutil/trace.go:171","msg":"trace[2019633914] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"386.182423ms","start":"2026-05-08T10:20:05.171152Z","end":"2026-05-08T10:20:05.557334Z","steps":["trace[2019633914] 'agreement among raft nodes before linearized reading' (duration: 386.086972ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.557384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.171142Z","time spent":"386.234163ms","remote":"127.0.0.1:55538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-05-08T10:20:05.557387Z","caller":"traceutil/trace.go:171","msg":"trace[1362328150] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"386.728669ms","start":"2026-05-08T10:20:05.170626Z","end":"2026-05-08T10:20:05.557355Z","steps":["trace[1362328150] 'agreement among raft nodes before linearized reading' (duration: 386.498826ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:20:05.55744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:20:05.170614Z","time spent":"386.81563ms","remote":"127.0.0.1:55562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-08T10:20:29.222496Z","caller":"traceutil/trace.go:171","msg":"trace[545590110] transaction","detail":"{read_only:false; response_revision:437; number_of_response:1; }","duration":"101.225269ms","start":"2026-05-08T10:20:29.121248Z","end":"2026-05-08T10:20:29.222473Z","steps":["trace[545590110] 'process raft request' (duration: 101.065147ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:09.162002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437162659,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T10:21:09.195308Z","caller":"traceutil/trace.go:171","msg":"trace[689305706] linearizableReadLoop","detail":"{readStateIndex:697; appliedIndex:696; }","duration":"534.053648ms","start":"2026-05-08T10:21:08.661233Z","end":"2026-05-08T10:21:09.195287Z","steps":["trace[689305706] 'read index received' (duration: 533.893331ms)","trace[689305706] 'applied index is now lower than readState.Index' (duration: 159.487µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:21:09.195613Z","caller":"traceutil/trace.go:171","msg":"trace[741958624] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"651.160717ms","start":"2026-05-08T10:21:08.544439Z","end":"2026-05-08T10:21:09.1956Z","steps":["trace[741958624] 'process raft request' (duration: 650.737098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:09.19579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:08.544418Z","time spent":"651.229061ms","remote":"127.0.0.1:55710","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-05-08T10:21:09.195869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.634284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:09.195896Z","caller":"traceutil/trace.go:171","msg":"trace[13116278] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"534.687998ms","start":"2026-05-08T10:21:08.661199Z","end":"2026-05-08T10:21:09.195887Z","steps":["trace[13116278] 'agreement among raft nodes before linearized reading' (duration: 534.643295ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:09.195922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:08.661185Z","time spent":"534.732209ms","remote":"127.0.0.1:55434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T10:21:09.196113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.374892ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:09.196197Z","caller":"traceutil/trace.go:171","msg":"trace[1085478078] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"504.513899ms","start":"2026-05-08T10:21:08.691664Z","end":"2026-05-08T10:21:09.196178Z","steps":["trace[1085478078] 'agreement among raft nodes before linearized reading' (duration: 504.364482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:09.196254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:08.691616Z","time spent":"504.627864ms","remote":"127.0.0.1:55446","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T10:21:09.196468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.543544ms","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-05-08T10:21:09.196526Z","caller":"traceutil/trace.go:171","msg":"trace[11157447] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:667; }","duration":"257.845878ms","start":"2026-05-08T10:21:08.938664Z","end":"2026-05-08T10:21:09.19651Z","steps":["trace[11157447] 'agreement among raft nodes before linearized reading' (duration: 257.398608ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:15.848179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.909322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:21:15.848897Z","caller":"traceutil/trace.go:171","msg":"trace[649086826] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:707; }","duration":"104.551169ms","start":"2026-05-08T10:21:15.744188Z","end":"2026-05-08T10:21:15.848739Z","steps":["trace[649086826] 'count revisions from in-memory index tree' (duration: 103.756365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:15.848332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.951361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:15.849273Z","caller":"traceutil/trace.go:171","msg":"trace[121584371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:707; }","duration":"156.892082ms","start":"2026-05-08T10:21:15.69232Z","end":"2026-05-08T10:21:15.849212Z","steps":["trace[121584371] 'range keys from in-memory index tree' (duration: 155.851688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:15.848392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.945636ms","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-05-08T10:21:15.849542Z","caller":"traceutil/trace.go:171","msg":"trace[811611899] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:707; }","duration":"355.117756ms","start":"2026-05-08T10:21:15.494348Z","end":"2026-05-08T10:21:15.849466Z","steps":["trace[811611899] 'range keys from in-memory index tree' (duration: 353.733867ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:15.849896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:15.494328Z","time spent":"355.301504ms","remote":"127.0.0.1:55710","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-05-08T10:21:16.544968Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437162817,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T10:21:16.707505Z","caller":"traceutil/trace.go:171","msg":"trace[1260767961] linearizableReadLoop","detail":"{readStateIndex:741; appliedIndex:740; }","duration":"663.538401ms","start":"2026-05-08T10:21:16.043945Z","end":"2026-05-08T10:21:16.707484Z","steps":["trace[1260767961] 'read index received' (duration: 663.251929ms)","trace[1260767961] 'applied index is now lower than readState.Index' (duration: 285.582µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:21:16.707942Z","caller":"traceutil/trace.go:171","msg":"trace[1404569765] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"752.734549ms","start":"2026-05-08T10:21:15.955164Z","end":"2026-05-08T10:21:16.707899Z","steps":["trace[1404569765] 'process raft request' (duration: 752.163575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:16.708221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:15.955142Z","time spent":"752.975439ms","remote":"127.0.0.1:55636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:21:16.708748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.181999ms","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-05-08T10:21:16.708856Z","caller":"traceutil/trace.go:171","msg":"trace[1149185468] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:709; }","duration":"664.94437ms","start":"2026-05-08T10:21:16.043894Z","end":"2026-05-08T10:21:16.708838Z","steps":["trace[1149185468] 'agreement among raft nodes before linearized reading' (duration: 663.938418ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:16.70895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:16.043881Z","time spent":"665.024314ms","remote":"127.0.0.1:55710","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":"warn","ts":"2026-05-08T10:21:17.276843Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437162821,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-08T10:21:17.559793Z","caller":"traceutil/trace.go:171","msg":"trace[1485861304] linearizableReadLoop","detail":"{readStateIndex:742; appliedIndex:741; }","duration":"783.741528ms","start":"2026-05-08T10:21:16.776021Z","end":"2026-05-08T10:21:17.559763Z","steps":["trace[1485861304] 'read index received' (duration: 783.55034ms)","trace[1485861304] 'applied index is now lower than readState.Index' (duration: 190.038µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:21:17.5599Z","caller":"traceutil/trace.go:171","msg":"trace[721870224] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"841.389161ms","start":"2026-05-08T10:21:16.718476Z","end":"2026-05-08T10:21:17.559866Z","steps":["trace[721870224] 'process raft request' (duration: 841.12567ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:17.559999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"783.958507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T10:21:17.560054Z","caller":"traceutil/trace.go:171","msg":"trace[1860510886] range","detail":"{range_begin:/registry/masterleases/199.19.213.138; range_end:; response_count:1; response_revision:710; }","duration":"784.02722ms","start":"2026-05-08T10:21:16.776014Z","end":"2026-05-08T10:21:17.560041Z","steps":["trace[1860510886] 'agreement among raft nodes before linearized reading' (duration: 783.854403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:17.56007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:16.718456Z","time spent":"841.537217ms","remote":"127.0.0.1:55710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:21:17.560089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:16.775965Z","time spent":"784.115974ms","remote":"127.0.0.1:55470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.138\" "} {"level":"warn","ts":"2026-05-08T10:21:17.560074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.35647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-08T10:21:17.560133Z","caller":"traceutil/trace.go:171","msg":"trace[324523811] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"328.501267ms","start":"2026-05-08T10:21:17.231617Z","end":"2026-05-08T10:21:17.560119Z","steps":["trace[324523811] 'agreement among raft nodes before linearized reading' (duration: 328.301189ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:17.560196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.231585Z","time spent":"328.601061ms","remote":"127.0.0.1:55710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-08T10:21:17.560214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.165666ms","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-05-08T10:21:17.560289Z","caller":"traceutil/trace.go:171","msg":"trace[1108071991] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:710; }","duration":"222.358134ms","start":"2026-05-08T10:21:17.337914Z","end":"2026-05-08T10:21:17.560272Z","steps":["trace[1108071991] 'agreement among raft nodes before linearized reading' (duration: 222.077992ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:18.192599Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437162824,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:18.692833Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437162824,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:18.925576Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.2707578s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-08T10:21:19.692103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999948964s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-05-08T10:21:19.6922Z","caller":"traceutil/trace.go:171","msg":"trace[309422109] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000096081s","start":"2026-05-08T10:21:17.69209Z","end":"2026-05-08T10:21:19.692186Z","steps":["trace[309422109] 'agreement among raft nodes before linearized reading' (duration: 1.999978786s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.692241Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.69207Z","time spent":"2.000163884s","remote":"127.0.0.1:55434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/05/08 10:21:19 WARNING: [core] [Server #5] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-05-08T10:21:19.724331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"924.995688ms","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-05-08T10:21:19.724385Z","caller":"traceutil/trace.go:171","msg":"trace[1378496648] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:710; }","duration":"925.05667ms","start":"2026-05-08T10:21:18.799321Z","end":"2026-05-08T10:21:19.724378Z","steps":["trace[1378496648] 'range keys from in-memory index tree' (duration: 924.986487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.725026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.069882666s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:21:19.72529Z","caller":"traceutil/trace.go:171","msg":"trace[746368259] linearizableReadLoop","detail":"{readStateIndex:747; appliedIndex:743; }","duration":"2.033136402s","start":"2026-05-08T10:21:17.692138Z","end":"2026-05-08T10:21:19.725274Z","steps":["trace[746368259] 'read index received' (duration: 1.233564787s)","trace[746368259] 'applied index is now lower than readState.Index' (duration: 799.570725ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:21:19.725384Z","caller":"traceutil/trace.go:171","msg":"trace[233729855] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"2.161459569s","start":"2026-05-08T10:21:17.563913Z","end":"2026-05-08T10:21:19.725373Z","steps":["trace[233729855] 'process raft request' (duration: 90.956247ms)","trace[233729855] 'compare' (duration: 2.069442908s)"],"step_count":2} {"level":"warn","ts":"2026-05-08T10:21:19.725442Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.563897Z","time spent":"2.161512041s","remote":"127.0.0.1:55710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:21:19.725777Z","caller":"traceutil/trace.go:171","msg":"trace[1343609003] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"2.161496551s","start":"2026-05-08T10:21:17.56427Z","end":"2026-05-08T10:21:19.725766Z","steps":["trace[1343609003] 'process raft request' (duration: 2.160845094s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.725831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.564243Z","time spent":"2.161558733s","remote":"127.0.0.1:55710","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:21:19.725907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.864386603s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-08T10:21:19.725962Z","caller":"traceutil/trace.go:171","msg":"trace[1548107459] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:714; }","duration":"1.864493968s","start":"2026-05-08T10:21:17.861455Z","end":"2026-05-08T10:21:19.725949Z","steps":["trace[1548107459] 'agreement among raft nodes before linearized reading' (duration: 1.864386234s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.726001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.861433Z","time spent":"1.864560251s","remote":"127.0.0.1:55906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":2,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"info","ts":"2026-05-08T10:21:19.726039Z","caller":"traceutil/trace.go:171","msg":"trace[439375376] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"2.12868814s","start":"2026-05-08T10:21:17.597328Z","end":"2026-05-08T10:21:19.726016Z","steps":["trace[439375376] 'process raft request' (duration: 2.127871647s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:19.72615Z","caller":"traceutil/trace.go:171","msg":"trace[49161783] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"2.095014835s","start":"2026-05-08T10:21:17.631126Z","end":"2026-05-08T10:21:19.726141Z","steps":["trace[49161783] 'process raft request' (duration: 2.094111838s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.726166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.811486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-05-08T10:21:19.726168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.597313Z","time spent":"2.128781044s","remote":"127.0.0.1:55470","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-08T10:21:19.7262Z","caller":"traceutil/trace.go:171","msg":"trace[1822221512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:714; }","duration":"161.875688ms","start":"2026-05-08T10:21:19.564314Z","end":"2026-05-08T10:21:19.72619Z","steps":["trace[1822221512] 'agreement among raft nodes before linearized reading' (duration: 161.730052ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.726209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.631107Z","time spent":"2.095063026s","remote":"127.0.0.1:55710","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-05-08T10:21:19.726277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.781735441s","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-05-08T10:21:19.726366Z","caller":"traceutil/trace.go:171","msg":"trace[1486913930] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:714; }","duration":"1.781808775s","start":"2026-05-08T10:21:17.944501Z","end":"2026-05-08T10:21:19.72631Z","steps":["trace[1486913930] 'agreement among raft nodes before linearized reading' (duration: 1.781632838s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.726402Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:17.944486Z","time spent":"1.781907499s","remote":"127.0.0.1:55710","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-05-08T10:21:19.906618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.760534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:19.906679Z","caller":"traceutil/trace.go:171","msg":"trace[1817175575] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:718; }","duration":"173.860118ms","start":"2026-05-08T10:21:19.732806Z","end":"2026-05-08T10:21:19.906666Z","steps":["trace[1817175575] 'agreement among raft nodes before linearized reading' (duration: 173.719293ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:19.906489Z","caller":"traceutil/trace.go:171","msg":"trace[1893012975] linearizableReadLoop","detail":"{readStateIndex:750; appliedIndex:748; }","duration":"112.517651ms","start":"2026-05-08T10:21:19.793868Z","end":"2026-05-08T10:21:19.906386Z","steps":["trace[1893012975] 'read index received' (duration: 111.992999ms)","trace[1893012975] 'applied index is now lower than readState.Index' (duration: 523.602µs)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:21:19.907004Z","caller":"traceutil/trace.go:171","msg":"trace[1168251624] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"176.331519ms","start":"2026-05-08T10:21:19.730091Z","end":"2026-05-08T10:21:19.906423Z","steps":["trace[1168251624] 'process raft request' (duration: 175.803078ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:19.907085Z","caller":"traceutil/trace.go:171","msg":"trace[1643903894] transaction","detail":"{read_only:false; response_revision:717; number_of_response:1; }","duration":"175.819819ms","start":"2026-05-08T10:21:19.73062Z","end":"2026-05-08T10:21:19.90644Z","steps":["trace[1643903894] 'process raft request' (duration: 175.697654ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:19.907219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.7757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T10:21:19.907257Z","caller":"traceutil/trace.go:171","msg":"trace[1652598979] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:718; }","duration":"111.849583ms","start":"2026-05-08T10:21:19.795398Z","end":"2026-05-08T10:21:19.907248Z","steps":["trace[1652598979] 'agreement among raft nodes before linearized reading' (duration: 111.677246ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:21.51574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.78068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:21.515806Z","caller":"traceutil/trace.go:171","msg":"trace[980376095] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:724; }","duration":"208.910635ms","start":"2026-05-08T10:21:21.306881Z","end":"2026-05-08T10:21:21.515792Z","steps":["trace[980376095] 'count revisions from in-memory index tree' (duration: 208.53703ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:21.516019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.092731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:21.516052Z","caller":"traceutil/trace.go:171","msg":"trace[799162469] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:724; }","duration":"392.504028ms","start":"2026-05-08T10:21:21.12354Z","end":"2026-05-08T10:21:21.516044Z","steps":["trace[799162469] 'count revisions from in-memory index tree' (duration: 392.013657ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:21.516078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:21.12352Z","time spent":"392.551629ms","remote":"127.0.0.1:55760","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-05-08T10:21:25.361291Z","caller":"traceutil/trace.go:171","msg":"trace[1438445886] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"184.128408ms","start":"2026-05-08T10:21:25.177136Z","end":"2026-05-08T10:21:25.361264Z","steps":["trace[1438445886] 'process raft request' (duration: 183.893659ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:36.104424Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437163142,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:36.605242Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437163142,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:37.105914Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4241157227437163142,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-08T10:21:37.314828Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.315874488s","expected-duration":"1s"} {"level":"info","ts":"2026-05-08T10:21:37.322545Z","caller":"traceutil/trace.go:171","msg":"trace[409375779] linearizableReadLoop","detail":"{readStateIndex:907; appliedIndex:906; }","duration":"1.719102808s","start":"2026-05-08T10:21:35.603384Z","end":"2026-05-08T10:21:37.322487Z","steps":["trace[409375779] 'read index received' (duration: 1.711621592s)","trace[409375779] 'applied index is now lower than readState.Index' (duration: 7.479665ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:21:37.322604Z","caller":"traceutil/trace.go:171","msg":"trace[1486070941] transaction","detail":"{read_only:false; response_revision:870; number_of_response:1; }","duration":"2.323664084s","start":"2026-05-08T10:21:34.998868Z","end":"2026-05-08T10:21:37.322532Z","steps":["trace[1486070941] 'process raft request' (duration: 2.316300463s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:37.32285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:34.998856Z","time spent":"2.323874111s","remote":"127.0.0.1:55636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4025,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-08T10:21:37.333363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.528879343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-08T10:21:37.333443Z","caller":"traceutil/trace.go:171","msg":"trace[106257270] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:870; }","duration":"1.529009148s","start":"2026-05-08T10:21:35.80442Z","end":"2026-05-08T10:21:37.333429Z","steps":["trace[106257270] 'agreement among raft nodes before linearized reading' (duration: 1.518408665s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:37.333488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:35.804399Z","time spent":"1.52908218s","remote":"127.0.0.1:55710","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-05-08T10:21:37.333474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.817867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.138\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-08T10:21:37.333571Z","caller":"traceutil/trace.go:171","msg":"trace[814371185] range","detail":"{range_begin:/registry/masterleases/199.19.213.138; range_end:; response_count:1; response_revision:870; }","duration":"553.962592ms","start":"2026-05-08T10:21:36.779586Z","end":"2026-05-08T10:21:37.333549Z","steps":["trace[814371185] 'agreement among raft nodes before linearized reading' (duration: 543.201194ms)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:37.333621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:36.779567Z","time spent":"554.044255ms","remote":"127.0.0.1:55470","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.138\" "} {"level":"warn","ts":"2026-05-08T10:21:37.333744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.529241796s","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-05-08T10:21:37.333749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.631013241s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-08T10:21:37.333809Z","caller":"traceutil/trace.go:171","msg":"trace[1787419630] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:870; }","duration":"1.631096294s","start":"2026-05-08T10:21:35.702693Z","end":"2026-05-08T10:21:37.33379Z","steps":["trace[1787419630] 'agreement among raft nodes before linearized reading' (duration: 1.620074257s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:37.333794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.348754318s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-08T10:21:37.333849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:35.702676Z","time spent":"1.631165327s","remote":"127.0.0.1:55434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-08T10:21:37.333835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.730438166s","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-05-08T10:21:37.333902Z","caller":"traceutil/trace.go:171","msg":"trace[869242669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:870; }","duration":"1.348910673s","start":"2026-05-08T10:21:35.98496Z","end":"2026-05-08T10:21:37.333871Z","steps":["trace[869242669] 'agreement among raft nodes before linearized reading' (duration: 1.337840674s)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:21:37.333927Z","caller":"traceutil/trace.go:171","msg":"trace[1075153482] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:870; }","duration":"1.73056321s","start":"2026-05-08T10:21:35.603336Z","end":"2026-05-08T10:21:37.333899Z","steps":["trace[1075153482] 'agreement among raft nodes before linearized reading' (duration: 1.719403248s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:37.333955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:35.984936Z","time spent":"1.349009186s","remote":"127.0.0.1:55710","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-05-08T10:21:37.333971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:35.603317Z","time spent":"1.730644823s","remote":"127.0.0.1:55710","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-05-08T10:21:37.334156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459146093s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-08T10:21:37.334208Z","caller":"traceutil/trace.go:171","msg":"trace[1733220002] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:870; }","duration":"1.459248046s","start":"2026-05-08T10:21:35.874942Z","end":"2026-05-08T10:21:37.33419Z","steps":["trace[1733220002] 'agreement among raft nodes before linearized reading' (duration: 1.447867678s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:37.334245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:35.874919Z","time spent":"1.459318009s","remote":"127.0.0.1:55710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-08T10:21:37.333838Z","caller":"traceutil/trace.go:171","msg":"trace[1136657872] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:870; }","duration":"1.529311918s","start":"2026-05-08T10:21:35.804462Z","end":"2026-05-08T10:21:37.333774Z","steps":["trace[1136657872] 'agreement among raft nodes before linearized reading' (duration: 1.518354654s)"],"step_count":1} {"level":"warn","ts":"2026-05-08T10:21:37.334731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-08T10:21:35.80445Z","time spent":"1.53026629s","remote":"127.0.0.1:55710","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-05-08T10:23:20.136867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.268315ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-08T10:23:20.136992Z","caller":"traceutil/trace.go:171","msg":"trace[2042663571] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"244.377103ms","start":"2026-05-08T10:23:19.892584Z","end":"2026-05-08T10:23:20.136961Z","steps":["trace[2042663571] 'process raft request' (duration: 75.939765ms)","trace[2042663571] 'compare' (duration: 168.162913ms)"],"step_count":2} {"level":"info","ts":"2026-05-08T10:23:20.145074Z","caller":"traceutil/trace.go:171","msg":"trace[1646074023] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"251.250385ms","start":"2026-05-08T10:23:19.893808Z","end":"2026-05-08T10:23:20.145058Z","steps":["trace[1646074023] 'process raft request' (duration: 251.175754ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:20.145102Z","caller":"traceutil/trace.go:171","msg":"trace[1720468494] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"251.328806ms","start":"2026-05-08T10:23:19.89374Z","end":"2026-05-08T10:23:20.145069Z","steps":["trace[1720468494] 'process raft request' (duration: 251.143393ms)"],"step_count":1} {"level":"info","ts":"2026-05-08T10:23:20.145228Z","caller":"traceutil/trace.go:171","msg":"trace[1042306922] transaction","detail":"{read_only:false; response_revision:1375; number_of_response:1; }","duration":"251.357907ms","start":"2026-05-08T10:23:19.893848Z","end":"2026-05-08T10:23:20.145206Z","steps":["trace[1042306922] 'process raft request' (duration: 251.175783ms)"],"step_count":1}