{"level":"warn","ts":"2026-07-29T00:55:27.974013Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T00:55:27.974088Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.113:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.113:2380","--initial-cluster=instance=https://199.204.45.113:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.113:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.113: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-07-29T00:55:27.974146Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-29T00:55:27.974158Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-07-29T00:55:27.974173Z","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-07-29T00:55:27.974804Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"]} {"level":"info","ts":"2026-07-29T00:55:27.97488Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.113: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-07-29T00:55:27.980458Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.382506ms"} {"level":"info","ts":"2026-07-29T00:55:27.988696Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a31e123290fcf0df","cluster-id":"37661d6ee45ed9e8"} {"level":"info","ts":"2026-07-29T00:55:27.988775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=()"} {"level":"info","ts":"2026-07-29T00:55:27.9888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 0"} {"level":"info","ts":"2026-07-29T00:55:27.988811Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a31e123290fcf0df [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-29T00:55:27.988826Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became follower at term 1"} {"level":"info","ts":"2026-07-29T00:55:27.988874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"warn","ts":"2026-07-29T00:55:27.994767Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-29T00:55:27.99611Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-29T00:55:27.997133Z","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-07-29T00:55:27.999177Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a31e123290fcf0df","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-29T00:55:27.999258Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a31e123290fcf0df","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-29T00:55:27.999418Z","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-07-29T00:55:27.99945Z","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-07-29T00:55:27.999458Z","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-07-29T00:55:28.001334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df switched to configuration voters=(11753852085873733855)"} {"level":"info","ts":"2026-07-29T00:55:28.004936Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","added-peer-id":"a31e123290fcf0df","added-peer-peer-urls":["https://199.204.45.113:2380"]} {"level":"info","ts":"2026-07-29T00:55:28.006281Z","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-07-29T00:55:28.006489Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-07-29T00:55:28.006532Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.113:2380"} {"level":"info","ts":"2026-07-29T00:55:28.006669Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a31e123290fcf0df","initial-advertise-peer-urls":["https://199.204.45.113:2380"],"listen-peer-urls":["https://199.204.45.113:2380"],"advertise-client-urls":["https://199.204.45.113:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.113:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-29T00:55:28.006719Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-29T00:55:28.089891Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df is starting a new election at term 1"} {"level":"info","ts":"2026-07-29T00:55:28.089944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became pre-candidate at term 1"} {"level":"info","ts":"2026-07-29T00:55:28.089981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgPreVoteResp from a31e123290fcf0df at term 1"} {"level":"info","ts":"2026-07-29T00:55:28.09Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became candidate at term 2"} {"level":"info","ts":"2026-07-29T00:55:28.090017Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df received MsgVoteResp from a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-07-29T00:55:28.090033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a31e123290fcf0df became leader at term 2"} {"level":"info","ts":"2026-07-29T00:55:28.09005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a31e123290fcf0df elected leader a31e123290fcf0df at term 2"} {"level":"info","ts":"2026-07-29T00:55:28.090804Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a31e123290fcf0df","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.113:2379]}","request-path":"/0/members/a31e123290fcf0df/attributes","cluster-id":"37661d6ee45ed9e8","publish-timeout":"7s"} {"level":"info","ts":"2026-07-29T00:55:28.090798Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:55:28.090972Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T00:55:28.091022Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T00:55:28.091411Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-29T00:55:28.091435Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-29T00:55:28.093889Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.113:2379"} {"level":"info","ts":"2026-07-29T00:55:28.094161Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"37661d6ee45ed9e8","local-member-id":"a31e123290fcf0df","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:55:28.094255Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:55:28.094304Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T00:55:28.097128Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-07-29T00:56:10.365106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.992734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-m4cj8\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-29T00:56:10.365231Z","caller":"traceutil/trace.go:171","msg":"trace[797474540] range","detail":"{range_begin:/registry/pods/kube-system/cilium-m4cj8; range_end:; response_count:1; response_revision:589; }","duration":"109.171319ms","start":"2026-07-29T00:56:10.256038Z","end":"2026-07-29T00:56:10.365209Z","steps":["trace[797474540] 'range keys from in-memory index tree' (duration: 108.8339ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:56:10.884539Z","caller":"traceutil/trace.go:171","msg":"trace[269819827] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"277.731364ms","start":"2026-07-29T00:56:10.606765Z","end":"2026-07-29T00:56:10.884496Z","steps":["trace[269819827] 'process raft request' (duration: 277.5571ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:11.478978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.294061ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T00:56:11.479191Z","caller":"traceutil/trace.go:171","msg":"trace[1594278575] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"510.510567ms","start":"2026-07-29T00:56:10.968652Z","end":"2026-07-29T00:56:11.479162Z","steps":["trace[1594278575] 'process raft request' (duration: 309.325375ms)","trace[1594278575] 'compare' (duration: 199.914781ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:56:11.479318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:56:10.968632Z","time spent":"510.6188ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:56:11.501807Z","caller":"traceutil/trace.go:171","msg":"trace[909033748] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"196.837145ms","start":"2026-07-29T00:56:11.304945Z","end":"2026-07-29T00:56:11.501782Z","steps":["trace[909033748] 'process raft request' (duration: 196.313482ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:26.584827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.374721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T00:56:26.585042Z","caller":"traceutil/trace.go:171","msg":"trace[854777322] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"273.034187ms","start":"2026-07-29T00:56:26.311987Z","end":"2026-07-29T00:56:26.585021Z","steps":["trace[854777322] 'process raft request' (duration: 106.386299ms)","trace[854777322] 'compare' (duration: 166.135986ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:56:26.585196Z","caller":"traceutil/trace.go:171","msg":"trace[233506531] linearizableReadLoop","detail":"{readStateIndex:780; appliedIndex:778; }","duration":"233.11207ms","start":"2026-07-29T00:56:26.352073Z","end":"2026-07-29T00:56:26.585185Z","steps":["trace[233506531] 'read index received' (duration: 66.415971ms)","trace[233506531] 'applied index is now lower than readState.Index' (duration: 166.692139ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:56:26.585259Z","caller":"traceutil/trace.go:171","msg":"trace[38086219] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"272.153526ms","start":"2026-07-29T00:56:26.313097Z","end":"2026-07-29T00:56:26.585251Z","steps":["trace[38086219] 'process raft request' (duration: 271.847879ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:56:26.585624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.494051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cnphd\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-07-29T00:56:26.585772Z","caller":"traceutil/trace.go:171","msg":"trace[1406732658] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-cnphd; range_end:; response_count:1; response_revision:756; }","duration":"233.672406ms","start":"2026-07-29T00:56:26.352051Z","end":"2026-07-29T00:56:26.585724Z","steps":["trace[1406732658] 'agreement among raft nodes before linearized reading' (duration: 233.224164ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:35.218969Z","caller":"traceutil/trace.go:171","msg":"trace[1481412561] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1112; }","duration":"169.348778ms","start":"2026-07-29T00:57:35.04952Z","end":"2026-07-29T00:57:35.218869Z","steps":["trace[1481412561] 'read index received' (duration: 155.67485ms)","trace[1481412561] 'applied index is now lower than readState.Index' (duration: 13.672688ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:57:35.219145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.646419ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-07-29T00:57:35.219174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.343485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-29T00:57:35.219185Z","caller":"traceutil/trace.go:171","msg":"trace[1249506853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1073; }","duration":"174.945226ms","start":"2026-07-29T00:57:35.04423Z","end":"2026-07-29T00:57:35.219175Z","steps":["trace[1249506853] 'agreement among raft nodes before linearized reading' (duration: 174.792953ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:35.219219Z","caller":"traceutil/trace.go:171","msg":"trace[570625195] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1073; }","duration":"177.407077ms","start":"2026-07-29T00:57:35.041798Z","end":"2026-07-29T00:57:35.219205Z","steps":["trace[570625195] 'agreement among raft nodes before linearized reading' (duration: 177.283574ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:35.21935Z","caller":"traceutil/trace.go:171","msg":"trace[1949129450] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"177.410577ms","start":"2026-07-29T00:57:35.041872Z","end":"2026-07-29T00:57:35.219282Z","steps":["trace[1949129450] 'process raft request' (duration: 163.355439ms)","trace[1949129450] 'compare' (duration: 13.433673ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:57:35.223652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.757608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T00:57:35.223738Z","caller":"traceutil/trace.go:171","msg":"trace[982139000] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1074; }","duration":"131.886531ms","start":"2026-07-29T00:57:35.091833Z","end":"2026-07-29T00:57:35.22372Z","steps":["trace[982139000] 'agreement among raft nodes before linearized reading' (duration: 131.736298ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:35.223845Z","caller":"traceutil/trace.go:171","msg":"trace[779993739] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"171.227784ms","start":"2026-07-29T00:57:35.052569Z","end":"2026-07-29T00:57:35.223797Z","steps":["trace[779993739] 'process raft request' (duration: 170.895496ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:43.509341Z","caller":"traceutil/trace.go:171","msg":"trace[291958183] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"165.210723ms","start":"2026-07-29T00:57:43.344101Z","end":"2026-07-29T00:57:43.509311Z","steps":["trace[291958183] 'process raft request' (duration: 165.060549ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:43.583236Z","caller":"traceutil/trace.go:171","msg":"trace[572092625] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"238.622719ms","start":"2026-07-29T00:57:43.344574Z","end":"2026-07-29T00:57:43.583197Z","steps":["trace[572092625] 'process raft request' (duration: 238.366353ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:43.583277Z","caller":"traceutil/trace.go:171","msg":"trace[1873658687] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"237.795278ms","start":"2026-07-29T00:57:43.345451Z","end":"2026-07-29T00:57:43.583246Z","steps":["trace[1873658687] 'process raft request' (duration: 237.668235ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:57:43.583493Z","caller":"traceutil/trace.go:171","msg":"trace[229791392] transaction","detail":"{read_only:false; response_revision:1103; number_of_response:1; }","duration":"237.85575ms","start":"2026-07-29T00:57:43.345466Z","end":"2026-07-29T00:57:43.583322Z","steps":["trace[229791392] 'process raft request' (duration: 237.691326ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:58:01.359327Z","caller":"traceutil/trace.go:171","msg":"trace[1547254485] linearizableReadLoop","detail":"{readStateIndex:1255; appliedIndex:1254; }","duration":"216.465374ms","start":"2026-07-29T00:58:01.14284Z","end":"2026-07-29T00:58:01.359305Z","steps":["trace[1547254485] 'read index received' (duration: 216.250119ms)","trace[1547254485] 'applied index is now lower than readState.Index' (duration: 214.015µs)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:58:01.35944Z","caller":"traceutil/trace.go:171","msg":"trace[828463387] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"220.291888ms","start":"2026-07-29T00:58:01.139117Z","end":"2026-07-29T00:58:01.359409Z","steps":["trace[828463387] 'process raft request' (duration: 220.012561ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:58:01.359514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.657259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-29T00:58:01.359542Z","caller":"traceutil/trace.go:171","msg":"trace[642008840] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1208; }","duration":"216.725511ms","start":"2026-07-29T00:58:01.142807Z","end":"2026-07-29T00:58:01.359533Z","steps":["trace[642008840] 'agreement among raft nodes before linearized reading' (duration: 216.581437ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:58:19.526599Z","caller":"traceutil/trace.go:171","msg":"trace[334704614] transaction","detail":"{read_only:false; response_revision:1288; number_of_response:1; }","duration":"112.035866ms","start":"2026-07-29T00:58:19.414534Z","end":"2026-07-29T00:58:19.52657Z","steps":["trace[334704614] 'process raft request' (duration: 111.80884ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:58:19.695812Z","caller":"traceutil/trace.go:171","msg":"trace[763133412] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"164.68511ms","start":"2026-07-29T00:58:19.531098Z","end":"2026-07-29T00:58:19.695783Z","steps":["trace[763133412] 'process raft request' (duration: 152.421959ms)","trace[763133412] 'compare' (duration: 11.960794ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T00:58:20.321449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.472953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-29T00:58:20.321523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.636113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-29T00:58:20.321585Z","caller":"traceutil/trace.go:171","msg":"trace[414555105] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1291; }","duration":"289.750476ms","start":"2026-07-29T00:58:20.031821Z","end":"2026-07-29T00:58:20.321571Z","steps":["trace[414555105] 'range keys from in-memory index tree' (duration: 278.338415ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:58:20.321543Z","caller":"traceutil/trace.go:171","msg":"trace[794824048] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1291; }","duration":"229.610356ms","start":"2026-07-29T00:58:20.091908Z","end":"2026-07-29T00:58:20.321518Z","steps":["trace[794824048] 'count revisions from in-memory index tree' (duration: 229.36409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:58:20.321676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.190352ms","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-07-29T00:58:20.321759Z","caller":"traceutil/trace.go:171","msg":"trace[916805411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1291; }","duration":"289.294346ms","start":"2026-07-29T00:58:20.03244Z","end":"2026-07-29T00:58:20.321734Z","steps":["trace[916805411] 'range keys from in-memory index tree' (duration: 278.439767ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:58:20.32174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.73834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-07-29T00:58:20.321833Z","caller":"traceutil/trace.go:171","msg":"trace[900928273] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1291; }","duration":"292.870903ms","start":"2026-07-29T00:58:20.028938Z","end":"2026-07-29T00:58:20.321809Z","steps":["trace[900928273] 'range keys from in-memory index tree' (duration: 278.718845ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:58:30.883515Z","caller":"traceutil/trace.go:171","msg":"trace[251813287] linearizableReadLoop","detail":"{readStateIndex:1425; appliedIndex:1423; }","duration":"210.970209ms","start":"2026-07-29T00:58:30.672523Z","end":"2026-07-29T00:58:30.883493Z","steps":["trace[251813287] 'read index received' (duration: 210.669622ms)","trace[251813287] 'applied index is now lower than readState.Index' (duration: 299.757µs)"],"step_count":2} {"level":"info","ts":"2026-07-29T00:58:30.883549Z","caller":"traceutil/trace.go:171","msg":"trace[1354848895] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"420.480761ms","start":"2026-07-29T00:58:30.463046Z","end":"2026-07-29T00:58:30.883527Z","steps":["trace[1354848895] 'process raft request' (duration: 420.267196ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:58:30.88369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.152964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"warn","ts":"2026-07-29T00:58:30.883714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:58:30.463024Z","time spent":"420.585833ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T00:58:30.883731Z","caller":"traceutil/trace.go:171","msg":"trace[1664757848] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1372; }","duration":"211.192415ms","start":"2026-07-29T00:58:30.672518Z","end":"2026-07-29T00:58:30.88371Z","steps":["trace[1664757848] 'agreement among raft nodes before linearized reading' (duration: 211.057021ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T00:58:30.883643Z","caller":"traceutil/trace.go:171","msg":"trace[1360412462] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"420.508262ms","start":"2026-07-29T00:58:30.463099Z","end":"2026-07-29T00:58:30.883607Z","steps":["trace[1360412462] 'process raft request' (duration: 420.350938ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T00:58:30.884646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T00:58:30.463089Z","time spent":"421.468965ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:04.281086Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356767047283639514,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:00:04.346409Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.033561462s","expected-duration":"1s"} {"level":"info","ts":"2026-07-29T01:00:04.347068Z","caller":"traceutil/trace.go:171","msg":"trace[1697556751] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"1.03430149s","start":"2026-07-29T01:00:03.312728Z","end":"2026-07-29T01:00:04.347029Z","steps":["trace[1697556751] 'process raft request' (duration: 1.033912831s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:04.3474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.312705Z","time spent":"1.034523185s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:05.500269Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.153622399s","expected-duration":"1s"} {"level":"info","ts":"2026-07-29T01:00:05.503314Z","caller":"traceutil/trace.go:171","msg":"trace[2027973276] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"1.570090178s","start":"2026-07-29T01:00:03.933196Z","end":"2026-07-29T01:00:05.503287Z","steps":["trace[2027973276] 'process raft request' (duration: 1.567248238s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.503462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.933179Z","time spent":"1.570211381s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:05.503593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.926843705s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:05.503644Z","caller":"traceutil/trace.go:171","msg":"trace[1279690724] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1798; }","duration":"1.926933338s","start":"2026-07-29T01:00:03.576694Z","end":"2026-07-29T01:00:05.503627Z","steps":["trace[1279690724] 'agreement among raft nodes before linearized reading' (duration: 1.926845295s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.503682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.576677Z","time spent":"1.926997119s","remote":"127.0.0.1:43694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-29T01:00:05.50379Z","caller":"traceutil/trace.go:171","msg":"trace[2015509129] linearizableReadLoop","detail":"{readStateIndex:1870; appliedIndex:1868; }","duration":"1.92702336s","start":"2026-07-29T01:00:03.576729Z","end":"2026-07-29T01:00:05.503753Z","steps":["trace[2015509129] 'read index received' (duration: 769.926014ms)","trace[2015509129] 'applied index is now lower than readState.Index' (duration: 1.157089985s)"],"step_count":2} {"level":"warn","ts":"2026-07-29T01:00:05.504039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.778477036s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-29T01:00:05.504071Z","caller":"traceutil/trace.go:171","msg":"trace[1787831026] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1798; }","duration":"1.778563298s","start":"2026-07-29T01:00:03.725501Z","end":"2026-07-29T01:00:05.504064Z","steps":["trace[1787831026] 'agreement among raft nodes before linearized reading' (duration: 1.778407734s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.504098Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:03.725487Z","time spent":"1.778604059s","remote":"127.0.0.1:43754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":138,"response size":31,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:00:05.50433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.96766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:05.504363Z","caller":"traceutil/trace.go:171","msg":"trace[217130343] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1798; }","duration":"442.014401ms","start":"2026-07-29T01:00:05.062341Z","end":"2026-07-29T01:00:05.504355Z","steps":["trace[217130343] 'agreement among raft nodes before linearized reading' (duration: 441.96306ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.504382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:05.062335Z","time spent":"442.042302ms","remote":"127.0.0.1:43206","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:00:05.504555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"487.254644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-07-29T01:00:05.50458Z","caller":"traceutil/trace.go:171","msg":"trace[853662433] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1798; }","duration":"487.314536ms","start":"2026-07-29T01:00:05.01726Z","end":"2026-07-29T01:00:05.504574Z","steps":["trace[853662433] 'agreement among raft nodes before linearized reading' (duration: 487.214303ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.504606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:05.017243Z","time spent":"487.352146ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T01:00:05.504658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.429299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-07-29T01:00:05.504669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221332598s","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-07-29T01:00:05.504714Z","caller":"traceutil/trace.go:171","msg":"trace[75181807] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1798; }","duration":"827.507312ms","start":"2026-07-29T01:00:04.677191Z","end":"2026-07-29T01:00:05.504698Z","steps":["trace[75181807] 'agreement among raft nodes before linearized reading' (duration: 827.343198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.504702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.22140343s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:535"} {"level":"warn","ts":"2026-07-29T01:00:05.50475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.67718Z","time spent":"827.561993ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-29T01:00:05.504755Z","caller":"traceutil/trace.go:171","msg":"trace[1182420837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1798; }","duration":"1.221443282s","start":"2026-07-29T01:00:04.283289Z","end":"2026-07-29T01:00:05.504733Z","steps":["trace[1182420837] 'agreement among raft nodes before linearized reading' (duration: 1.221205016s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:00:05.504773Z","caller":"traceutil/trace.go:171","msg":"trace[337146600] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1798; }","duration":"1.221524303s","start":"2026-07-29T01:00:04.283229Z","end":"2026-07-29T01:00:05.504753Z","steps":["trace[337146600] 'agreement among raft nodes before linearized reading' (duration: 1.221294307s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.504799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.283282Z","time spent":"1.221508573s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-29T01:00:05.504838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.283208Z","time spent":"1.221618326s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":75,"response count":1,"response size":558,"request content":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-29T01:00:05.504871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.803125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T01:00:05.50477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.618806ms","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-07-29T01:00:05.504898Z","caller":"traceutil/trace.go:171","msg":"trace[178489170] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1798; }","duration":"845.872536ms","start":"2026-07-29T01:00:04.659018Z","end":"2026-07-29T01:00:05.50489Z","steps":["trace[178489170] 'agreement among raft nodes before linearized reading' (duration: 845.829995ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.504893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.452979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T01:00:05.504927Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.658995Z","time spent":"845.926357ms","remote":"127.0.0.1:43106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true "} {"level":"info","ts":"2026-07-29T01:00:05.50494Z","caller":"traceutil/trace.go:171","msg":"trace[1655976956] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:1798; }","duration":"931.52069ms","start":"2026-07-29T01:00:04.573405Z","end":"2026-07-29T01:00:05.504926Z","steps":["trace[1655976956] 'agreement among raft nodes before linearized reading' (duration: 931.460009ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.504987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.573394Z","time spent":"931.585144ms","remote":"127.0.0.1:34460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"info","ts":"2026-07-29T01:00:05.504912Z","caller":"traceutil/trace.go:171","msg":"trace[1093292371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1798; }","duration":"492.77916ms","start":"2026-07-29T01:00:05.012119Z","end":"2026-07-29T01:00:05.504898Z","steps":["trace[1093292371] 'agreement among raft nodes before linearized reading' (duration: 492.496073ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.505086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:05.012108Z","time spent":"492.969236ms","remote":"127.0.0.1:43910","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-07-29T01:00:05.505132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.221814012s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-29T01:00:05.505221Z","caller":"traceutil/trace.go:171","msg":"trace[962474101] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1798; }","duration":"1.221939915s","start":"2026-07-29T01:00:04.283254Z","end":"2026-07-29T01:00:05.505194Z","steps":["trace[962474101] 'agreement among raft nodes before linearized reading' (duration: 1.221613256s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:05.505271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:04.283234Z","time spent":"1.222027747s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-29T01:00:41.203708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356767047283639915,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:00:41.704817Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356767047283639915,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:00:42.205869Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356767047283639915,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:00:42.562358Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.974735251s","expected-duration":"1s"} {"level":"info","ts":"2026-07-29T01:00:42.565267Z","caller":"traceutil/trace.go:171","msg":"trace[1735419864] transaction","detail":"{read_only:false; response_revision:1964; number_of_response:1; }","duration":"1.977298174s","start":"2026-07-29T01:00:40.587517Z","end":"2026-07-29T01:00:42.564815Z","steps":["trace[1735419864] 'process raft request' (duration: 1.975001937s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.56602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:40.587502Z","time spent":"1.977824498s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:00:42.569609Z","caller":"traceutil/trace.go:171","msg":"trace[1698861246] linearizableReadLoop","detail":"{readStateIndex:2044; appliedIndex:2042; }","duration":"1.866443176s","start":"2026-07-29T01:00:40.703146Z","end":"2026-07-29T01:00:42.569589Z","steps":["trace[1698861246] 'read index received' (duration: 1.859488924s)","trace[1698861246] 'applied index is now lower than readState.Index' (duration: 6.953382ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T01:00:42.569863Z","caller":"traceutil/trace.go:171","msg":"trace[1467491658] transaction","detail":"{read_only:false; response_revision:1965; number_of_response:1; }","duration":"898.759868ms","start":"2026-07-29T01:00:41.671041Z","end":"2026-07-29T01:00:42.569801Z","steps":["trace[1467491658] 'process raft request' (duration: 898.43558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.569914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.866726563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T01:00:42.569951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.419986394s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-07-29T01:00:42.570726Z","caller":"traceutil/trace.go:171","msg":"trace[1672011498] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1965; }","duration":"1.420810776s","start":"2026-07-29T01:00:41.149901Z","end":"2026-07-29T01:00:42.570712Z","steps":["trace[1672011498] 'agreement among raft nodes before linearized reading' (duration: 1.419942413s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.570721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.415504644s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:525"} {"level":"warn","ts":"2026-07-29T01:00:42.570793Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.149871Z","time spent":"1.420892398s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-29T01:00:42.569993Z","caller":"traceutil/trace.go:171","msg":"trace[1203068767] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1965; }","duration":"1.866879286s","start":"2026-07-29T01:00:40.703084Z","end":"2026-07-29T01:00:42.569964Z","steps":["trace[1203068767] 'agreement among raft nodes before linearized reading' (duration: 1.866686442s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.570971Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:40.703051Z","time spent":"1.867907073s","remote":"127.0.0.1:43756","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-07-29T01:00:42.570788Z","caller":"traceutil/trace.go:171","msg":"trace[1868866810] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1965; }","duration":"1.415605027s","start":"2026-07-29T01:00:41.155166Z","end":"2026-07-29T01:00:42.570771Z","steps":["trace[1868866810] 'agreement among raft nodes before linearized reading' (duration: 1.415416792s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.570132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.87771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-07-29T01:00:42.57113Z","caller":"traceutil/trace.go:171","msg":"trace[944012778] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1965; }","duration":"882.893046ms","start":"2026-07-29T01:00:41.688227Z","end":"2026-07-29T01:00:42.57112Z","steps":["trace[944012778] 'agreement among raft nodes before linearized reading' (duration: 881.813149ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.571135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.155148Z","time spent":"1.415966436s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":548,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-29T01:00:42.571158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.688217Z","time spent":"882.932776ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"warn","ts":"2026-07-29T01:00:42.570092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.671018Z","time spent":"898.908031ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T01:00:42.570355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"915.341051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.571472Z","caller":"traceutil/trace.go:171","msg":"trace[1412698308] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:1965; }","duration":"916.473328ms","start":"2026-07-29T01:00:41.654984Z","end":"2026-07-29T01:00:42.571457Z","steps":["trace[1412698308] 'agreement among raft nodes before linearized reading' (duration: 915.34094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.571506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.654973Z","time spent":"916.522229ms","remote":"127.0.0.1:34476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:00:42.570411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.643165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-07-29T01:00:42.571564Z","caller":"traceutil/trace.go:171","msg":"trace[944712889] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1965; }","duration":"882.814523ms","start":"2026-07-29T01:00:41.688732Z","end":"2026-07-29T01:00:42.571547Z","steps":["trace[944712889] 'agreement among raft nodes before linearized reading' (duration: 881.607813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.57162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.688719Z","time spent":"882.884675ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T01:00:42.570401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.897828ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.571686Z","caller":"traceutil/trace.go:171","msg":"trace[1317828011] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1965; }","duration":"307.25506ms","start":"2026-07-29T01:00:42.264418Z","end":"2026-07-29T01:00:42.571673Z","steps":["trace[1317828011] 'agreement among raft nodes before linearized reading' (duration: 305.840815ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.57172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:42.264405Z","time spent":"307.303812ms","remote":"127.0.0.1:43834","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:00:42.570445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.034794ms","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-07-29T01:00:42.571762Z","caller":"traceutil/trace.go:171","msg":"trace[1582990875] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1965; }","duration":"885.374887ms","start":"2026-07-29T01:00:41.686376Z","end":"2026-07-29T01:00:42.571751Z","steps":["trace[1582990875] 'agreement among raft nodes before linearized reading' (duration: 884.001443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.571794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.686356Z","time spent":"885.428378ms","remote":"127.0.0.1:43910","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":"warn","ts":"2026-07-29T01:00:42.570495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"884.314021ms","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-07-29T01:00:42.57187Z","caller":"traceutil/trace.go:171","msg":"trace[786291029] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1965; }","duration":"885.696545ms","start":"2026-07-29T01:00:41.686166Z","end":"2026-07-29T01:00:42.571863Z","steps":["trace[786291029] 'agreement among raft nodes before linearized reading' (duration: 884.293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.571939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.686162Z","time spent":"885.769926ms","remote":"127.0.0.1:43910","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-07-29T01:00:42.570537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.708615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-29T01:00:42.572023Z","caller":"traceutil/trace.go:171","msg":"trace[150195231] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1965; }","duration":"887.201531ms","start":"2026-07-29T01:00:41.684813Z","end":"2026-07-29T01:00:42.572015Z","steps":["trace[150195231] 'agreement among raft nodes before linearized reading' (duration: 885.692745ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.572046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.684807Z","time spent":"887.232202ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-29T01:00:42.570517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.833831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.572124Z","caller":"traceutil/trace.go:171","msg":"trace[1841436794] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:1965; }","duration":"254.460031ms","start":"2026-07-29T01:00:42.317655Z","end":"2026-07-29T01:00:42.572115Z","steps":["trace[1841436794] 'agreement among raft nodes before linearized reading' (duration: 252.78333ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.570585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.201333472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T01:00:42.572298Z","caller":"traceutil/trace.go:171","msg":"trace[1569411542] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1965; }","duration":"1.203008593s","start":"2026-07-29T01:00:41.369205Z","end":"2026-07-29T01:00:42.572214Z","steps":["trace[1569411542] 'agreement among raft nodes before linearized reading' (duration: 1.201363763s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.572444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.369176Z","time spent":"1.203211078s","remote":"127.0.0.1:43040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:00:42.570628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.107331881s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.113\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-29T01:00:42.572714Z","caller":"traceutil/trace.go:171","msg":"trace[1783251990] range","detail":"{range_begin:/registry/masterleases/199.204.45.113; range_end:; response_count:1; response_revision:1965; }","duration":"1.109424473s","start":"2026-07-29T01:00:41.463281Z","end":"2026-07-29T01:00:42.572706Z","steps":["trace[1783251990] 'agreement among raft nodes before linearized reading' (duration: 1.107314622s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:00:42.57285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:00:41.463276Z","time spent":"1.109564888s","remote":"127.0.0.1:43716","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.113\" "} {"level":"warn","ts":"2026-07-29T01:02:48.944546Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356767047283641398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:02:49.44508Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17356767047283641398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T01:02:49.680483Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.302194717s","expected-duration":"1s"} {"level":"info","ts":"2026-07-29T01:02:49.680842Z","caller":"traceutil/trace.go:171","msg":"trace[579802410] transaction","detail":"{read_only:false; response_revision:2567; number_of_response:1; }","duration":"1.302620867s","start":"2026-07-29T01:02:48.378195Z","end":"2026-07-29T01:02:49.680815Z","steps":["trace[579802410] 'process raft request' (duration: 1.302489764s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.680986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:48.37818Z","time spent":"1.302733009s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:02:49.681481Z","caller":"traceutil/trace.go:171","msg":"trace[1174993675] linearizableReadLoop","detail":"{readStateIndex:2674; appliedIndex:2673; }","duration":"1.237711925s","start":"2026-07-29T01:02:48.443748Z","end":"2026-07-29T01:02:49.68146Z","steps":["trace[1174993675] 'read index received' (duration: 1.237076319s)","trace[1174993675] 'applied index is now lower than readState.Index' (duration: 634.856µs)"],"step_count":2} {"level":"warn","ts":"2026-07-29T01:02:49.681686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.23793527s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-07-29T01:02:49.681697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"518.627012ms","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-07-29T01:02:49.681726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.237346316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-07-29T01:02:49.681737Z","caller":"traceutil/trace.go:171","msg":"trace[1573798020] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2568; }","duration":"1.238018002s","start":"2026-07-29T01:02:48.443706Z","end":"2026-07-29T01:02:49.681724Z","steps":["trace[1573798020] 'agreement among raft nodes before linearized reading' (duration: 1.237848958s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.681746Z","caller":"traceutil/trace.go:171","msg":"trace[1775051703] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2568; }","duration":"518.715494ms","start":"2026-07-29T01:02:49.163018Z","end":"2026-07-29T01:02:49.681734Z","steps":["trace[1775051703] 'agreement among raft nodes before linearized reading' (duration: 518.579091ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.681769Z","caller":"traceutil/trace.go:171","msg":"trace[343190185] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2568; }","duration":"1.237418237s","start":"2026-07-29T01:02:48.444338Z","end":"2026-07-29T01:02:49.681756Z","steps":["trace[343190185] 'agreement among raft nodes before linearized reading' (duration: 1.237222772s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.681816Z","caller":"traceutil/trace.go:171","msg":"trace[1945598317] transaction","detail":"{read_only:false; response_revision:2568; number_of_response:1; }","duration":"686.252242ms","start":"2026-07-29T01:02:48.995555Z","end":"2026-07-29T01:02:49.681807Z","steps":["trace[1945598317] 'process raft request' (duration: 685.788811ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.681862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105482039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T01:02:49.681872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"517.916175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-07-29T01:02:49.681878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:48.995531Z","time spent":"686.314693ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T01:02:49.681894Z","caller":"traceutil/trace.go:171","msg":"trace[2025697620] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2568; }","duration":"1.10554739s","start":"2026-07-29T01:02:48.576337Z","end":"2026-07-29T01:02:49.681885Z","steps":["trace[2025697620] 'agreement among raft nodes before linearized reading' (duration: 1.105503289s)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.681899Z","caller":"traceutil/trace.go:171","msg":"trace[1379789854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2568; }","duration":"517.965766ms","start":"2026-07-29T01:02:49.163925Z","end":"2026-07-29T01:02:49.681891Z","steps":["trace[1379789854] 'agreement among raft nodes before linearized reading' (duration: 517.887934ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.681931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.163913Z","time spent":"518.012957ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-29T01:02:49.681937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.024071474s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2566"} {"level":"warn","ts":"2026-07-29T01:02:49.681971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.392292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"warn","ts":"2026-07-29T01:02:49.682006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:48.576317Z","time spent":"1.105601172s","remote":"127.0.0.1:43700","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-07-29T01:02:49.681816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:48.444333Z","time spent":"1.237474468s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-07-29T01:02:49.682051Z","caller":"traceutil/trace.go:171","msg":"trace[1593209301] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2568; }","duration":"507.503464ms","start":"2026-07-29T01:02:49.17453Z","end":"2026-07-29T01:02:49.682033Z","steps":["trace[1593209301] 'agreement among raft nodes before linearized reading' (duration: 507.264628ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.682084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.634792ms","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-07-29T01:02:49.68212Z","caller":"traceutil/trace.go:171","msg":"trace[1826434460] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2568; }","duration":"522.692764ms","start":"2026-07-29T01:02:49.159419Z","end":"2026-07-29T01:02:49.682112Z","steps":["trace[1826434460] 'agreement among raft nodes before linearized reading' (duration: 522.602832ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.682116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.937975ms","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-07-29T01:02:49.681771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:48.443691Z","time spent":"1.238072543s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-29T01:02:49.682154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.174519Z","time spent":"507.611566ms","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-07-29T01:02:49.682165Z","caller":"traceutil/trace.go:171","msg":"trace[206411887] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2568; }","duration":"538.021727ms","start":"2026-07-29T01:02:49.144132Z","end":"2026-07-29T01:02:49.682153Z","steps":["trace[206411887] 'agreement among raft nodes before linearized reading' (duration: 537.903834ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.682201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.836764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-29T01:02:49.682212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.144114Z","time spent":"538.083999ms","remote":"127.0.0.1:43910","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":"info","ts":"2026-07-29T01:02:49.682235Z","caller":"traceutil/trace.go:171","msg":"trace[967320457] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:2568; }","duration":"307.910476ms","start":"2026-07-29T01:02:49.374315Z","end":"2026-07-29T01:02:49.682226Z","steps":["trace[967320457] 'agreement among raft nodes before linearized reading' (duration: 307.858054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.682266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.374263Z","time spent":"307.995848ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-29T01:02:49.682023Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"507.853813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-29T01:02:49.68178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.162999Z","time spent":"518.773365ms","remote":"127.0.0.1:43910","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-07-29T01:02:49.682304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.230445592s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-07-29T01:02:49.682319Z","caller":"traceutil/trace.go:171","msg":"trace[1646507036] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2568; }","duration":"508.202992ms","start":"2026-07-29T01:02:49.174106Z","end":"2026-07-29T01:02:49.682309Z","steps":["trace[1646507036] 'agreement among raft nodes before linearized reading' (duration: 507.691619ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T01:02:49.682006Z","caller":"traceutil/trace.go:171","msg":"trace[483369379] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:2568; }","duration":"1.024172937s","start":"2026-07-29T01:02:48.657815Z","end":"2026-07-29T01:02:49.681988Z","steps":["trace[483369379] 'agreement among raft nodes before linearized reading' (duration: 1.023994712s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.682395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:48.657805Z","time spent":"1.024580527s","remote":"127.0.0.1:43850","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":1,"response size":2589,"request content":"key:\"/registry/pods/default/test-pvc-pod\" "} {"level":"info","ts":"2026-07-29T01:02:49.682352Z","caller":"traceutil/trace.go:171","msg":"trace[369407702] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2568; }","duration":"1.230510854s","start":"2026-07-29T01:02:48.451827Z","end":"2026-07-29T01:02:49.682338Z","steps":["trace[369407702] 'agreement among raft nodes before linearized reading' (duration: 1.230404282s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T01:02:49.682492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:48.451816Z","time spent":"1.230649048s","remote":"127.0.0.1:43910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-07-29T01:02:49.682356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.17408Z","time spent":"508.267693ms","remote":"127.0.0.1:43910","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-07-29T01:02:49.682153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T01:02:49.159409Z","time spent":"522.738005ms","remote":"127.0.0.1:43910","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\" "}