{"level":"warn","ts":"2026-05-09T12:52:03.804814Z","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-09T12:52:03.8049Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.85: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.85:2380","--initial-cluster=instance=https://199.19.213.85:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.85:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.85: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-09T12:52:03.80501Z","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-09T12:52:03.805023Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.85:2380"]} {"level":"info","ts":"2026-05-09T12:52:03.805044Z","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-09T12:52:03.805617Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"]} {"level":"info","ts":"2026-05-09T12:52:03.805686Z","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.85:2380"],"listen-peer-urls":["https://199.19.213.85:2380"],"advertise-client-urls":["https://199.19.213.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.85: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-09T12:52:03.810796Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.835655ms"} {"level":"info","ts":"2026-05-09T12:52:03.818206Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6a0c678c4e560a44","cluster-id":"dbaaf49260b7a32b"} {"level":"info","ts":"2026-05-09T12:52:03.818284Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=()"} {"level":"info","ts":"2026-05-09T12:52:03.818308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became follower at term 0"} {"level":"info","ts":"2026-05-09T12:52:03.818318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6a0c678c4e560a44 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-09T12:52:03.818334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became follower at term 1"} {"level":"info","ts":"2026-05-09T12:52:03.818382Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=(7641596520048233028)"} {"level":"warn","ts":"2026-05-09T12:52:03.825505Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-09T12:52:03.826917Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-09T12:52:03.827829Z","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-09T12:52:03.830099Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6a0c678c4e560a44","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-09T12:52:03.83049Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6a0c678c4e560a44","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-09T12:52:03.830544Z","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-09T12:52:03.830666Z","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-09T12:52:03.83068Z","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-09T12:52:03.836525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 switched to configuration voters=(7641596520048233028)"} {"level":"info","ts":"2026-05-09T12:52:03.836681Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dbaaf49260b7a32b","local-member-id":"6a0c678c4e560a44","added-peer-id":"6a0c678c4e560a44","added-peer-peer-urls":["https://199.19.213.85:2380"]} {"level":"info","ts":"2026-05-09T12:52:03.839982Z","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-09T12:52:03.840656Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6a0c678c4e560a44","initial-advertise-peer-urls":["https://199.19.213.85:2380"],"listen-peer-urls":["https://199.19.213.85:2380"],"advertise-client-urls":["https://199.19.213.85:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.85:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-09T12:52:03.8407Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-09T12:52:03.841262Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.85:2380"} {"level":"info","ts":"2026-05-09T12:52:03.841306Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.85:2380"} {"level":"info","ts":"2026-05-09T12:52:04.21933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 is starting a new election at term 1"} {"level":"info","ts":"2026-05-09T12:52:04.219378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-09T12:52:04.219397Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 received MsgPreVoteResp from 6a0c678c4e560a44 at term 1"} {"level":"info","ts":"2026-05-09T12:52:04.219408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became candidate at term 2"} {"level":"info","ts":"2026-05-09T12:52:04.219413Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 received MsgVoteResp from 6a0c678c4e560a44 at term 2"} {"level":"info","ts":"2026-05-09T12:52:04.219421Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6a0c678c4e560a44 became leader at term 2"} {"level":"info","ts":"2026-05-09T12:52:04.219428Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6a0c678c4e560a44 elected leader 6a0c678c4e560a44 at term 2"} {"level":"info","ts":"2026-05-09T12:52:04.221554Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:52:04.223338Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6a0c678c4e560a44","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.85:2379]}","request-path":"/0/members/6a0c678c4e560a44/attributes","cluster-id":"dbaaf49260b7a32b","publish-timeout":"7s"} {"level":"info","ts":"2026-05-09T12:52:04.223346Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:52:04.22347Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-09T12:52:04.223804Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-09T12:52:04.22382Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-09T12:52:04.224069Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dbaaf49260b7a32b","local-member-id":"6a0c678c4e560a44","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:52:04.224231Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:52:04.224275Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-09T12:52:04.226121Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.85:2379"} {"level":"info","ts":"2026-05-09T12:52:04.227177Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-09T12:52:08.880879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.676325ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-09T12:52:08.880965Z","caller":"traceutil/trace.go:171","msg":"trace[1008573926] linearizableReadLoop","detail":"{readStateIndex:228; appliedIndex:226; }","duration":"413.162383ms","start":"2026-05-09T12:52:08.467791Z","end":"2026-05-09T12:52:08.880954Z","steps":["trace[1008573926] 'read index received' (duration: 17.27687ms)","trace[1008573926] 'applied index is now lower than readState.Index' (duration: 395.884823ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:52:08.881051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.25255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:08.881071Z","caller":"traceutil/trace.go:171","msg":"trace[146130112] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:0; response_revision:222; }","duration":"413.308194ms","start":"2026-05-09T12:52:08.467758Z","end":"2026-05-09T12:52:08.881067Z","steps":["trace[146130112] 'agreement among raft nodes before linearized reading' (duration: 413.24258ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:08.881036Z","caller":"traceutil/trace.go:171","msg":"trace[341740791] transaction","detail":"{read_only:false; response_revision:222; number_of_response:1; }","duration":"422.262178ms","start":"2026-05-09T12:52:08.458721Z","end":"2026-05-09T12:52:08.880983Z","steps":["trace[341740791] 'process raft request' (duration: 85.207226ms)","trace[341740791] 'compare' (duration: 336.583987ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:52:08.881094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.467746Z","time spent":"413.342837ms","remote":"127.0.0.1:46996","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-05-09T12:52:08.881332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.45871Z","time spent":"422.42048ms","remote":"127.0.0.1:46894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":753,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:52:09.112563Z","caller":"traceutil/trace.go:171","msg":"trace[1050563909] transaction","detail":"{read_only:false; response_revision:223; number_of_response:1; }","duration":"507.519967ms","start":"2026-05-09T12:52:08.605016Z","end":"2026-05-09T12:52:09.112536Z","steps":["trace[1050563909] 'process raft request' (duration: 507.278789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.112719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.604998Z","time spent":"507.651398ms","remote":"127.0.0.1:46894","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-05-09T12:52:09.204753Z","caller":"traceutil/trace.go:171","msg":"trace[1752330053] transaction","detail":"{read_only:false; number_of_response:0; response_revision:223; }","duration":"495.989532ms","start":"2026-05-09T12:52:08.708737Z","end":"2026-05-09T12:52:09.204726Z","steps":["trace[1752330053] 'process raft request' (duration: 495.810399ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:09.204827Z","caller":"traceutil/trace.go:171","msg":"trace[1310526834] transaction","detail":"{read_only:false; response_revision:224; number_of_response:1; }","duration":"481.227348ms","start":"2026-05-09T12:52:08.72356Z","end":"2026-05-09T12:52:09.204788Z","steps":["trace[1310526834] 'process raft request' (duration: 481.072006ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.204869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.7087Z","time spent":"496.121021ms","remote":"127.0.0.1:46978","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-05-09T12:52:09.204874Z","caller":"traceutil/trace.go:171","msg":"trace[86768369] linearizableReadLoop","detail":"{readStateIndex:235; appliedIndex:229; }","duration":"323.873525ms","start":"2026-05-09T12:52:08.880984Z","end":"2026-05-09T12:52:09.204858Z","steps":["trace[86768369] 'read index received' (duration: 231.872367ms)","trace[86768369] 'applied index is now lower than readState.Index' (duration: 92.000208ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:52:09.204962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.723534Z","time spent":"481.368148ms","remote":"127.0.0.1:46984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3959,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-09T12:52:09.204964Z","caller":"traceutil/trace.go:171","msg":"trace[774427327] transaction","detail":"{read_only:false; response_revision:225; number_of_response:1; }","duration":"480.668756ms","start":"2026-05-09T12:52:08.724279Z","end":"2026-05-09T12:52:09.204948Z","steps":["trace[774427327] 'process raft request' (duration: 480.423738ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.205054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.724268Z","time spent":"480.732231ms","remote":"127.0.0.1:46984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5877,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T12:52:09.205147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"599.699699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:09.205177Z","caller":"traceutil/trace.go:171","msg":"trace[905841381] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:226; }","duration":"599.764083ms","start":"2026-05-09T12:52:08.605406Z","end":"2026-05-09T12:52:09.20517Z","steps":["trace[905841381] 'agreement among raft nodes before linearized reading' (duration: 599.689578ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.205196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.605389Z","time spent":"599.802847ms","remote":"127.0.0.1:47082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-05-09T12:52:09.205205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"680.327665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:09.205267Z","caller":"traceutil/trace.go:171","msg":"trace[1804105923] range","detail":"{range_begin:/registry/deployments/kube-system/; range_end:/registry/deployments/kube-system0; response_count:0; response_revision:226; }","duration":"680.408531ms","start":"2026-05-09T12:52:08.524823Z","end":"2026-05-09T12:52:09.205232Z","steps":["trace[1804105923] 'agreement among raft nodes before linearized reading' (duration: 680.339026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.205271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.666768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"warn","ts":"2026-05-09T12:52:09.205299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.524801Z","time spent":"680.490227ms","remote":"127.0.0.1:47278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/deployments/kube-system/\" range_end:\"/registry/deployments/kube-system0\" "} {"level":"info","ts":"2026-05-09T12:52:09.205339Z","caller":"traceutil/trace.go:171","msg":"trace[2107434246] transaction","detail":"{read_only:false; number_of_response:0; response_revision:226; }","duration":"480.195771ms","start":"2026-05-09T12:52:08.725137Z","end":"2026-05-09T12:52:09.205333Z","steps":["trace[2107434246] 'process raft request' (duration: 479.696554ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:09.205304Z","caller":"traceutil/trace.go:171","msg":"trace[2021504689] transaction","detail":"{read_only:false; response_revision:226; number_of_response:1; }","duration":"480.225803ms","start":"2026-05-09T12:52:08.725021Z","end":"2026-05-09T12:52:09.205246Z","steps":["trace[2021504689] 'process raft request' (duration: 479.735487ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.205374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.72513Z","time spent":"480.227573ms","remote":"127.0.0.1:46984","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-05-09T12:52:09.205411Z","caller":"traceutil/trace.go:171","msg":"trace[1297475045] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:226; }","duration":"597.814609ms","start":"2026-05-09T12:52:08.60754Z","end":"2026-05-09T12:52:09.205355Z","steps":["trace[1297475045] 'agreement among raft nodes before linearized reading' (duration: 597.616674ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:09.20546Z","caller":"traceutil/trace.go:171","msg":"trace[1878933985] transaction","detail":"{read_only:false; number_of_response:0; response_revision:225; }","duration":"481.061075ms","start":"2026-05-09T12:52:08.724394Z","end":"2026-05-09T12:52:09.205456Z","steps":["trace[1878933985] 'process raft request' (duration: 480.338452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.205456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.607533Z","time spent":"597.911317ms","remote":"127.0.0.1:47220","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-05-09T12:52:09.205454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.725001Z","time spent":"480.385875ms","remote":"127.0.0.1:46984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T12:52:09.205484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.724371Z","time spent":"481.100068ms","remote":"127.0.0.1:46984","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":28,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T12:52:09.20547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.328836ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:09.205555Z","caller":"traceutil/trace.go:171","msg":"trace[540168321] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:0; response_revision:226; }","duration":"549.496838ms","start":"2026-05-09T12:52:08.656036Z","end":"2026-05-09T12:52:09.205533Z","steps":["trace[540168321] 'agreement among raft nodes before linearized reading' (duration: 549.087788ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.205603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.656011Z","time spent":"549.582634ms","remote":"127.0.0.1:47082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-09T12:52:09.3563Z","caller":"traceutil/trace.go:171","msg":"trace[1277484721] transaction","detail":"{read_only:false; response_revision:227; number_of_response:1; }","duration":"238.721967ms","start":"2026-05-09T12:52:09.117542Z","end":"2026-05-09T12:52:09.356264Z","steps":["trace[1277484721] 'process raft request' (duration: 208.111145ms)","trace[1277484721] 'compare' (duration: 30.468411ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:52:09.356352Z","caller":"traceutil/trace.go:171","msg":"trace[1930589638] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"145.704843ms","start":"2026-05-09T12:52:09.210618Z","end":"2026-05-09T12:52:09.356323Z","steps":["trace[1930589638] 'process raft request' (duration: 145.65603ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:09.356674Z","caller":"traceutil/trace.go:171","msg":"trace[1784867764] linearizableReadLoop","detail":"{readStateIndex:236; appliedIndex:235; }","duration":"151.741982ms","start":"2026-05-09T12:52:09.204916Z","end":"2026-05-09T12:52:09.356657Z","steps":["trace[1784867764] 'read index received' (duration: 120.746552ms)","trace[1784867764] 'applied index is now lower than readState.Index' (duration: 30.99346ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:52:09.356868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.198326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:09.356919Z","caller":"traceutil/trace.go:171","msg":"trace[1556241869] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:228; }","duration":"133.279341ms","start":"2026-05-09T12:52:09.223628Z","end":"2026-05-09T12:52:09.356907Z","steps":["trace[1556241869] 'agreement among raft nodes before linearized reading' (duration: 133.170123ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.356943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.671392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"info","ts":"2026-05-09T12:52:09.357021Z","caller":"traceutil/trace.go:171","msg":"trace[574754459] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:228; }","duration":"150.795482ms","start":"2026-05-09T12:52:09.206208Z","end":"2026-05-09T12:52:09.357003Z","steps":["trace[574754459] 'agreement among raft nodes before linearized reading' (duration: 150.594637ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.357071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.117004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4016"} {"level":"warn","ts":"2026-05-09T12:52:09.357123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.047316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2920"} {"level":"info","ts":"2026-05-09T12:52:09.357135Z","caller":"traceutil/trace.go:171","msg":"trace[1456450825] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:228; }","duration":"146.208631ms","start":"2026-05-09T12:52:09.210911Z","end":"2026-05-09T12:52:09.35712Z","steps":["trace[1456450825] 'agreement among raft nodes before linearized reading' (duration: 146.088962ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:09.357156Z","caller":"traceutil/trace.go:171","msg":"trace[1844584371] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:228; }","duration":"150.101209ms","start":"2026-05-09T12:52:09.207047Z","end":"2026-05-09T12:52:09.357148Z","steps":["trace[1844584371] 'agreement among raft nodes before linearized reading' (duration: 150.042085ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.357232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.160774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:3466"} {"level":"info","ts":"2026-05-09T12:52:09.357271Z","caller":"traceutil/trace.go:171","msg":"trace[265025589] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:228; }","duration":"150.228349ms","start":"2026-05-09T12:52:09.207033Z","end":"2026-05-09T12:52:09.357262Z","steps":["trace[265025589] 'agreement among raft nodes before linearized reading' (duration: 150.167894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.357072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.537438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-05-09T12:52:09.357355Z","caller":"traceutil/trace.go:171","msg":"trace[451971063] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:228; }","duration":"472.851071ms","start":"2026-05-09T12:52:08.884496Z","end":"2026-05-09T12:52:09.357347Z","steps":["trace[451971063] 'agreement among raft nodes before linearized reading' (duration: 472.531627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.357356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.835451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-09T12:52:09.357381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:08.884481Z","time spent":"472.892004ms","remote":"127.0.0.1:46918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-09T12:52:09.357413Z","caller":"traceutil/trace.go:171","msg":"trace[657733681] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:0; response_revision:228; }","duration":"142.900415ms","start":"2026-05-09T12:52:09.214499Z","end":"2026-05-09T12:52:09.357399Z","steps":["trace[657733681] 'agreement among raft nodes before linearized reading' (duration: 142.805138ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:09.357535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.033388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-05-09T12:52:09.357569Z","caller":"traceutil/trace.go:171","msg":"trace[530585011] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:228; }","duration":"146.083022ms","start":"2026-05-09T12:52:09.211477Z","end":"2026-05-09T12:52:09.35756Z","steps":["trace[530585011] 'agreement among raft nodes before linearized reading' (duration: 146.026948ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:34.447718Z","caller":"traceutil/trace.go:171","msg":"trace[1802847850] linearizableReadLoop","detail":"{readStateIndex:507; appliedIndex:506; }","duration":"103.099852ms","start":"2026-05-09T12:52:34.344594Z","end":"2026-05-09T12:52:34.447694Z","steps":["trace[1802847850] 'read index received' (duration: 89.609204ms)","trace[1802847850] 'applied index is now lower than readState.Index' (duration: 13.489998ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:52:34.447787Z","caller":"traceutil/trace.go:171","msg":"trace[1592473549] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"109.501115ms","start":"2026-05-09T12:52:34.338247Z","end":"2026-05-09T12:52:34.447748Z","steps":["trace[1592473549] 'process raft request' (duration: 95.880077ms)","trace[1592473549] 'compare' (duration: 13.441899ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:52:34.447891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.274961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:30408"} {"level":"info","ts":"2026-05-09T12:52:34.447918Z","caller":"traceutil/trace.go:171","msg":"trace[2110545226] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/tcproutes.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:487; }","duration":"103.31959ms","start":"2026-05-09T12:52:34.344589Z","end":"2026-05-09T12:52:34.447908Z","steps":["trace[2110545226] 'agreement among raft nodes before linearized reading' (duration: 103.238331ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:34.450523Z","caller":"traceutil/trace.go:171","msg":"trace[1861277364] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"100.322387ms","start":"2026-05-09T12:52:34.350186Z","end":"2026-05-09T12:52:34.450509Z","steps":["trace[1861277364] 'process raft request' (duration: 99.418175ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:34.450605Z","caller":"traceutil/trace.go:171","msg":"trace[293026907] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"105.298602ms","start":"2026-05-09T12:52:34.345299Z","end":"2026-05-09T12:52:34.450598Z","steps":["trace[293026907] 'process raft request' (duration: 103.966084ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:40.413751Z","caller":"traceutil/trace.go:171","msg":"trace[1400957083] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"124.226077ms","start":"2026-05-09T12:52:40.289498Z","end":"2026-05-09T12:52:40.413724Z","steps":["trace[1400957083] 'process raft request' (duration: 123.527489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:40.707171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.349296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:40.707262Z","caller":"traceutil/trace.go:171","msg":"trace[1690494190] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:573; }","duration":"158.487795ms","start":"2026-05-09T12:52:40.548753Z","end":"2026-05-09T12:52:40.707241Z","steps":["trace[1690494190] 'range keys from in-memory index tree' (duration: 158.265446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:40.707389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.29153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:40.707478Z","caller":"traceutil/trace.go:171","msg":"trace[318685828] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:573; }","duration":"165.417829ms","start":"2026-05-09T12:52:40.542034Z","end":"2026-05-09T12:52:40.707452Z","steps":["trace[318685828] 'range keys from in-memory index tree' (duration: 165.2232ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:40.898523Z","caller":"traceutil/trace.go:171","msg":"trace[930654400] linearizableReadLoop","detail":"{readStateIndex:595; appliedIndex:594; }","duration":"183.942056ms","start":"2026-05-09T12:52:40.714558Z","end":"2026-05-09T12:52:40.8985Z","steps":["trace[930654400] 'read index received' (duration: 183.647206ms)","trace[930654400] 'applied index is now lower than readState.Index' (duration: 291.19µs)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:52:40.898928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.316125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-4ljmr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-05-09T12:52:40.899002Z","caller":"traceutil/trace.go:171","msg":"trace[1042000474] range","detail":"{range_begin:/registry/pods/kube-system/cilium-4ljmr; range_end:; response_count:1; response_revision:574; }","duration":"184.454185ms","start":"2026-05-09T12:52:40.714508Z","end":"2026-05-09T12:52:40.898963Z","steps":["trace[1042000474] 'agreement among raft nodes before linearized reading' (duration: 184.103516ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:40.89947Z","caller":"traceutil/trace.go:171","msg":"trace[1701450210] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"187.650457ms","start":"2026-05-09T12:52:40.71178Z","end":"2026-05-09T12:52:40.89943Z","steps":["trace[1701450210] 'process raft request' (duration: 186.443139ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:41.474073Z","caller":"traceutil/trace.go:171","msg":"trace[1839669192] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"368.318416ms","start":"2026-05-09T12:52:41.105722Z","end":"2026-05-09T12:52:41.474041Z","steps":["trace[1839669192] 'process raft request' (duration: 363.784842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:52:41.474508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:52:41.105683Z","time spent":"368.491576ms","remote":"127.0.0.1:46904","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036301,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-09T12:52:42.977025Z","caller":"traceutil/trace.go:171","msg":"trace[2030977667] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"152.654516ms","start":"2026-05-09T12:52:42.824337Z","end":"2026-05-09T12:52:42.976992Z","steps":["trace[2030977667] 'process raft request' (duration: 112.692698ms)","trace[2030977667] 'compare' (duration: 39.797649ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:52:42.996495Z","caller":"traceutil/trace.go:171","msg":"trace[951625254] linearizableReadLoop","detail":"{readStateIndex:634; appliedIndex:632; }","duration":"167.171852ms","start":"2026-05-09T12:52:42.829267Z","end":"2026-05-09T12:52:42.996439Z","steps":["trace[951625254] 'read index received' (duration: 107.936259ms)","trace[951625254] 'applied index is now lower than readState.Index' (duration: 59.224233ms)"],"step_count":2} {"level":"warn","ts":"2026-05-09T12:52:42.996718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.407482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:52:42.996768Z","caller":"traceutil/trace.go:171","msg":"trace[1585354566] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:612; }","duration":"167.529952ms","start":"2026-05-09T12:52:42.829223Z","end":"2026-05-09T12:52:42.996753Z","steps":["trace[1585354566] 'agreement among raft nodes before linearized reading' (duration: 167.422742ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:42.996609Z","caller":"traceutil/trace.go:171","msg":"trace[466599378] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"172.041651ms","start":"2026-05-09T12:52:42.824524Z","end":"2026-05-09T12:52:42.996565Z","steps":["trace[466599378] 'process raft request' (duration: 171.745131ms)"],"step_count":1} {"level":"info","ts":"2026-05-09T12:52:46.068815Z","caller":"traceutil/trace.go:171","msg":"trace[392377846] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"115.514323ms","start":"2026-05-09T12:52:45.953253Z","end":"2026-05-09T12:52:46.068767Z","steps":["trace[392377846] 'process raft request' (duration: 115.237822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:02.963641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":739890016586592668,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-09T12:53:03.437985Z","caller":"traceutil/trace.go:171","msg":"trace[572806247] linearizableReadLoop","detail":"{readStateIndex:828; appliedIndex:826; }","duration":"974.733206ms","start":"2026-05-09T12:53:02.463226Z","end":"2026-05-09T12:53:03.437959Z","steps":["trace[572806247] 'read index received' (duration: 971.871285ms)","trace[572806247] 'applied index is now lower than readState.Index' (duration: 2.860251ms)"],"step_count":2} {"level":"info","ts":"2026-05-09T12:53:03.438031Z","caller":"traceutil/trace.go:171","msg":"trace[845115184] transaction","detail":"{read_only:false; response_revision:801; number_of_response:1; }","duration":"951.69947ms","start":"2026-05-09T12:53:02.486287Z","end":"2026-05-09T12:53:03.437987Z","steps":["trace[845115184] 'process raft request' (duration: 951.534907ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.438186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.486269Z","time spent":"951.845062ms","remote":"127.0.0.1:46894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":833,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-09T12:53:03.438267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"975.015081ms","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-09T12:53:03.438262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"899.550841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-09T12:53:03.438314Z","caller":"traceutil/trace.go:171","msg":"trace[1430499276] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:801; }","duration":"975.115023ms","start":"2026-05-09T12:53:02.463187Z","end":"2026-05-09T12:53:03.438302Z","steps":["trace[1430499276] 'agreement among raft nodes before linearized reading' (duration: 974.92231ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.43832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.92399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-09T12:53:03.438352Z","caller":"traceutil/trace.go:171","msg":"trace[97220919] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:801; }","duration":"899.704573ms","start":"2026-05-09T12:53:02.538628Z","end":"2026-05-09T12:53:03.438333Z","steps":["trace[97220919] 'agreement among raft nodes before linearized reading' (duration: 899.53287ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.438353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.46317Z","time spent":"975.172484ms","remote":"127.0.0.1:47082","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-05-09T12:53:03.438375Z","caller":"traceutil/trace.go:171","msg":"trace[580555270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:801; }","duration":"351.036023ms","start":"2026-05-09T12:53:03.087325Z","end":"2026-05-09T12:53:03.438361Z","steps":["trace[580555270] 'agreement among raft nodes before linearized reading' (duration: 350.846679ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.438397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.538614Z","time spent":"899.773364ms","remote":"127.0.0.1:46814","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-09T12:53:03.438404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:03.087307Z","time spent":"351.092103ms","remote":"127.0.0.1:47082","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-05-09T12:53:03.43852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"721.667503ms","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-09T12:53:03.438533Z","caller":"traceutil/trace.go:171","msg":"trace[1501904932] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:801; }","duration":"721.711295ms","start":"2026-05-09T12:53:02.716818Z","end":"2026-05-09T12:53:03.438529Z","steps":["trace[1501904932] 'agreement among raft nodes before linearized reading' (duration: 721.661694ms)"],"step_count":1} {"level":"warn","ts":"2026-05-09T12:53:03.438545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-09T12:53:02.716801Z","time spent":"721.740765ms","remote":"127.0.0.1:47082","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\" "}