{"level":"warn","ts":"2026-04-27T02:42:16.737862Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T02:42:16.737976Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.205: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.205:2380","--initial-cluster=instance=https://199.19.213.205:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.205:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.205:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-27T02:42:16.73807Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-27T02:42:16.738088Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.205:2380"]} {"level":"info","ts":"2026-04-27T02:42:16.738113Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T02:42:16.73894Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.205:2379"]} {"level":"info","ts":"2026-04-27T02:42:16.739043Z","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.205:2380"],"listen-peer-urls":["https://199.19.213.205:2380"],"advertise-client-urls":["https://199.19.213.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.205:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-27T02:42:16.743341Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.946838ms"} {"level":"info","ts":"2026-04-27T02:42:16.750874Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f69f598a0f963672","cluster-id":"740466542a91995c"} {"level":"info","ts":"2026-04-27T02:42:16.750944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 switched to configuration voters=()"} {"level":"info","ts":"2026-04-27T02:42:16.75096Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became follower at term 0"} {"level":"info","ts":"2026-04-27T02:42:16.750975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f69f598a0f963672 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-27T02:42:16.75098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became follower at term 1"} {"level":"info","ts":"2026-04-27T02:42:16.751009Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 switched to configuration voters=(17771021104129128050)"} {"level":"warn","ts":"2026-04-27T02:42:16.758367Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-27T02:42:16.759693Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-27T02:42:16.761578Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-27T02:42:16.763868Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f69f598a0f963672","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-27T02:42:16.764103Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f69f598a0f963672","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-27T02:42:16.765685Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T02:42:16.765771Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T02:42:16.765783Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-27T02:42:16.766071Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 switched to configuration voters=(17771021104129128050)"} {"level":"info","ts":"2026-04-27T02:42:16.766163Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"740466542a91995c","local-member-id":"f69f598a0f963672","added-peer-id":"f69f598a0f963672","added-peer-peer-urls":["https://199.19.213.205:2380"]} {"level":"info","ts":"2026-04-27T02:42:16.773541Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-27T02:42:16.773765Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f69f598a0f963672","initial-advertise-peer-urls":["https://199.19.213.205:2380"],"listen-peer-urls":["https://199.19.213.205:2380"],"advertise-client-urls":["https://199.19.213.205:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.205:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-27T02:42:16.773797Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-27T02:42:16.773911Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.205:2380"} {"level":"info","ts":"2026-04-27T02:42:16.773926Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.205:2380"} {"level":"info","ts":"2026-04-27T02:42:17.051661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 is starting a new election at term 1"} {"level":"info","ts":"2026-04-27T02:42:17.051936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-27T02:42:17.052055Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 received MsgPreVoteResp from f69f598a0f963672 at term 1"} {"level":"info","ts":"2026-04-27T02:42:17.052215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became candidate at term 2"} {"level":"info","ts":"2026-04-27T02:42:17.052302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 received MsgVoteResp from f69f598a0f963672 at term 2"} {"level":"info","ts":"2026-04-27T02:42:17.05238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f69f598a0f963672 became leader at term 2"} {"level":"info","ts":"2026-04-27T02:42:17.052471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f69f598a0f963672 elected leader f69f598a0f963672 at term 2"} {"level":"info","ts":"2026-04-27T02:42:17.053546Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T02:42:17.055029Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"740466542a91995c","local-member-id":"f69f598a0f963672","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T02:42:17.055447Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T02:42:17.055543Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-27T02:42:17.055597Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-27T02:42:17.055164Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T02:42:17.055191Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f69f598a0f963672","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.205:2379]}","request-path":"/0/members/f69f598a0f963672/attributes","cluster-id":"740466542a91995c","publish-timeout":"7s"} {"level":"info","ts":"2026-04-27T02:42:17.055215Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-27T02:42:17.055583Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-27T02:42:17.059286Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-27T02:42:17.06729Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.205:2379"} {"level":"info","ts":"2026-04-27T02:42:42.207262Z","caller":"traceutil/trace.go:171","msg":"trace[124385209] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"198.274161ms","start":"2026-04-27T02:42:42.00897Z","end":"2026-04-27T02:42:42.207245Z","steps":["trace[124385209] 'read index received' (duration: 188.215478ms)","trace[124385209] 'applied index is now lower than readState.Index' (duration: 10.057703ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:42:42.207294Z","caller":"traceutil/trace.go:171","msg":"trace[383387342] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"204.806364ms","start":"2026-04-27T02:42:42.002468Z","end":"2026-04-27T02:42:42.207274Z","steps":["trace[383387342] 'process raft request' (duration: 194.64024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:42:42.207456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.464152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-04-27T02:42:42.20749Z","caller":"traceutil/trace.go:171","msg":"trace[694617870] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:600; }","duration":"198.531543ms","start":"2026-04-27T02:42:42.00895Z","end":"2026-04-27T02:42:42.207482Z","steps":["trace[694617870] 'agreement among raft nodes before linearized reading' (duration: 198.381512ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:42:42.207973Z","caller":"traceutil/trace.go:171","msg":"trace[707505709] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"175.584024ms","start":"2026-04-27T02:42:42.032369Z","end":"2026-04-27T02:42:42.207953Z","steps":["trace[707505709] 'process raft request' (duration: 175.239131ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:42:49.13215Z","caller":"traceutil/trace.go:171","msg":"trace[741629203] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:685; }","duration":"146.155069ms","start":"2026-04-27T02:42:48.985933Z","end":"2026-04-27T02:42:49.132088Z","steps":["trace[741629203] 'read index received' (duration: 141.938969ms)","trace[741629203] 'applied index is now lower than readState.Index' (duration: 4.21416ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:42:49.135527Z","caller":"traceutil/trace.go:171","msg":"trace[2084655869] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"199.536222ms","start":"2026-04-27T02:42:48.935914Z","end":"2026-04-27T02:42:49.135451Z","steps":["trace[2084655869] 'process raft request' (duration: 192.051996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:42:49.135856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.897957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-27T02:42:49.135963Z","caller":"traceutil/trace.go:171","msg":"trace[2011458585] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:664; }","duration":"150.014142ms","start":"2026-04-27T02:42:48.985908Z","end":"2026-04-27T02:42:49.135922Z","steps":["trace[2011458585] 'agreement among raft nodes before linearized reading' (duration: 149.766991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:42:49.136029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.112035ms","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":"warn","ts":"2026-04-27T02:42:49.135891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.94584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-27T02:42:49.136101Z","caller":"traceutil/trace.go:171","msg":"trace[223933879] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:664; }","duration":"107.19818ms","start":"2026-04-27T02:42:49.028864Z","end":"2026-04-27T02:42:49.136062Z","steps":["trace[223933879] 'agreement among raft nodes before linearized reading' (duration: 107.089675ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:42:49.136107Z","caller":"traceutil/trace.go:171","msg":"trace[312040091] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:664; }","duration":"126.196691ms","start":"2026-04-27T02:42:49.009887Z","end":"2026-04-27T02:42:49.136084Z","steps":["trace[312040091] 'agreement among raft nodes before linearized reading' (duration: 125.922688ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:09.175894Z","caller":"traceutil/trace.go:171","msg":"trace[994228110] transaction","detail":"{read_only:false; response_revision:1703; number_of_response:1; }","duration":"105.871225ms","start":"2026-04-27T02:45:09.069998Z","end":"2026-04-27T02:45:09.175869Z","steps":["trace[994228110] 'process raft request' (duration: 103.678141ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:09.178006Z","caller":"traceutil/trace.go:171","msg":"trace[1393989445] transaction","detail":"{read_only:false; response_revision:1704; number_of_response:1; }","duration":"104.838048ms","start":"2026-04-27T02:45:09.073152Z","end":"2026-04-27T02:45:09.17799Z","steps":["trace[1393989445] 'process raft request' (duration: 104.736987ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:09.178118Z","caller":"traceutil/trace.go:171","msg":"trace[247197426] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1703; }","duration":"107.542481ms","start":"2026-04-27T02:45:09.070545Z","end":"2026-04-27T02:45:09.178087Z","steps":["trace[247197426] 'process raft request' (duration: 107.275867ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:25.459204Z","caller":"traceutil/trace.go:171","msg":"trace[1843998520] linearizableReadLoop","detail":"{readStateIndex:2294; appliedIndex:2293; }","duration":"148.772369ms","start":"2026-04-27T02:45:25.310406Z","end":"2026-04-27T02:45:25.459178Z","steps":["trace[1843998520] 'read index received' (duration: 148.445684ms)","trace[1843998520] 'applied index is now lower than readState.Index' (duration: 325.355µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:45:25.459476Z","caller":"traceutil/trace.go:171","msg":"trace[1096392429] transaction","detail":"{read_only:false; response_revision:2206; number_of_response:1; }","duration":"178.394599ms","start":"2026-04-27T02:45:25.280839Z","end":"2026-04-27T02:45:25.459234Z","steps":["trace[1096392429] 'process raft request' (duration: 178.164555ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:25.459715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.296047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-033f1c02-135f-40a6-9141-d6d0ad4ec12c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-27T02:45:25.459762Z","caller":"traceutil/trace.go:171","msg":"trace[1966800736] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-033f1c02-135f-40a6-9141-d6d0ad4ec12c; range_end:; response_count:1; response_revision:2206; }","duration":"149.363758ms","start":"2026-04-27T02:45:25.310387Z","end":"2026-04-27T02:45:25.45975Z","steps":["trace[1966800736] 'agreement among raft nodes before linearized reading' (duration: 149.140355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:25.595305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.748534ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-04-27T02:45:25.595684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.202896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-controller-24zdt\" ","response":"range_response_count:1 size:7308"} {"level":"info","ts":"2026-04-27T02:45:25.595746Z","caller":"traceutil/trace.go:171","msg":"trace[109725190] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-controller-24zdt; range_end:; response_count:1; response_revision:2206; }","duration":"100.295068ms","start":"2026-04-27T02:45:25.495434Z","end":"2026-04-27T02:45:25.595729Z","steps":["trace[109725190] 'agreement among raft nodes before linearized reading' (duration: 100.109456ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.430605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"538.158891ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-27T02:45:26.430737Z","caller":"traceutil/trace.go:171","msg":"trace[1772902778] transaction","detail":"{read_only:false; response_revision:2209; number_of_response:1; }","duration":"719.423662ms","start":"2026-04-27T02:45:25.7113Z","end":"2026-04-27T02:45:26.430723Z","steps":["trace[1772902778] 'process raft request' (duration: 180.783484ms)","trace[1772902778] 'compare' (duration: 537.820116ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:45:26.430787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.711282Z","time spent":"719.483633ms","remote":"127.0.0.1:56214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1203,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:45:26.43105Z","caller":"traceutil/trace.go:171","msg":"trace[67971639] transaction","detail":"{read_only:false; response_revision:2210; number_of_response:1; }","duration":"719.693387ms","start":"2026-04-27T02:45:25.711347Z","end":"2026-04-27T02:45:26.43104Z","steps":["trace[67971639] 'process raft request' (duration: 719.328872ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.431103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.711325Z","time spent":"719.753998ms","remote":"127.0.0.1:56330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1734,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:45:26.431279Z","caller":"traceutil/trace.go:171","msg":"trace[2087177724] transaction","detail":"{read_only:false; response_revision:2212; number_of_response:1; }","duration":"719.749217ms","start":"2026-04-27T02:45:25.711523Z","end":"2026-04-27T02:45:26.431272Z","steps":["trace[2087177724] 'process raft request' (duration: 719.499324ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.431326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.711503Z","time spent":"719.798978ms","remote":"127.0.0.1:56330","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1760,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:45:26.431379Z","caller":"traceutil/trace.go:171","msg":"trace[558096023] transaction","detail":"{read_only:false; response_revision:2214; number_of_response:1; }","duration":"718.361567ms","start":"2026-04-27T02:45:25.713012Z","end":"2026-04-27T02:45:26.431374Z","steps":["trace[558096023] 'process raft request' (duration: 718.262335ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:26.431372Z","caller":"traceutil/trace.go:171","msg":"trace[119927052] transaction","detail":"{read_only:false; response_revision:2213; number_of_response:1; }","duration":"719.120188ms","start":"2026-04-27T02:45:25.712232Z","end":"2026-04-27T02:45:26.431352Z","steps":["trace[119927052] 'process raft request' (duration: 718.978075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.431426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.712991Z","time spent":"718.409627ms","remote":"127.0.0.1:56532","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6114,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:45:26.431457Z","caller":"traceutil/trace.go:171","msg":"trace[1951440847] linearizableReadLoop","detail":"{readStateIndex:2303; appliedIndex:2297; }","duration":"674.905112ms","start":"2026-04-27T02:45:25.756543Z","end":"2026-04-27T02:45:26.431448Z","steps":["trace[1951440847] 'read index received' (duration: 135.548993ms)","trace[1951440847] 'applied index is now lower than readState.Index' (duration: 539.355279ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:45:26.431395Z","caller":"traceutil/trace.go:171","msg":"trace[1568261851] transaction","detail":"{read_only:false; response_revision:2215; number_of_response:1; }","duration":"547.242886ms","start":"2026-04-27T02:45:25.884134Z","end":"2026-04-27T02:45:26.431377Z","steps":["trace[1568261851] 'process raft request' (duration: 547.195055ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:26.431481Z","caller":"traceutil/trace.go:171","msg":"trace[1331748489] transaction","detail":"{read_only:false; response_revision:2211; number_of_response:1; }","duration":"719.711547ms","start":"2026-04-27T02:45:25.71137Z","end":"2026-04-27T02:45:26.431081Z","steps":["trace[1331748489] 'process raft request' (duration: 719.555044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.431798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.246367ms","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-04-27T02:45:26.431848Z","caller":"traceutil/trace.go:171","msg":"trace[1446308999] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2215; }","duration":"675.348078ms","start":"2026-04-27T02:45:25.756487Z","end":"2026-04-27T02:45:26.431835Z","steps":["trace[1446308999] 'agreement among raft nodes before linearized reading' (duration: 675.153455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.43188Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.756465Z","time spent":"675.407679ms","remote":"127.0.0.1:56314","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-04-27T02:45:26.431644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.884086Z","time spent":"547.535801ms","remote":"127.0.0.1:56314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:45:26.431746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.712223Z","time spent":"719.391441ms","remote":"127.0.0.1:56214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1170,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:45:26.432992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.711363Z","time spent":"720.468918ms","remote":"127.0.0.1:56214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1153,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-27T02:45:26.434601Z","caller":"traceutil/trace.go:171","msg":"trace[1541421337] transaction","detail":"{read_only:false; response_revision:2216; number_of_response:1; }","duration":"359.497402ms","start":"2026-04-27T02:45:26.075091Z","end":"2026-04-27T02:45:26.434588Z","steps":["trace[1541421337] 'process raft request' (duration: 359.426191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.434666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:26.07507Z","time spent":"359.560142ms","remote":"127.0.0.1:56230","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8108,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-27T02:45:26.442969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.524622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-033f1c02-135f-40a6-9141-d6d0ad4ec12c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-27T02:45:26.443047Z","caller":"traceutil/trace.go:171","msg":"trace[1144247017] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-033f1c02-135f-40a6-9141-d6d0ad4ec12c; range_end:; response_count:1; response_revision:2217; }","duration":"504.639013ms","start":"2026-04-27T02:45:25.9384Z","end":"2026-04-27T02:45:26.443039Z","steps":["trace[1144247017] 'agreement among raft nodes before linearized reading' (duration: 504.47264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.443065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.140165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-04-27T02:45:26.443096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.938383Z","time spent":"504.693793ms","remote":"127.0.0.1:56232","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-033f1c02-135f-40a6-9141-d6d0ad4ec12c\" "} {"level":"info","ts":"2026-04-27T02:45:26.443098Z","caller":"traceutil/trace.go:171","msg":"trace[670418443] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2217; }","duration":"340.187826ms","start":"2026-04-27T02:45:26.1029Z","end":"2026-04-27T02:45:26.443088Z","steps":["trace[670418443] 'agreement among raft nodes before linearized reading' (duration: 340.124475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.443132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:26.102888Z","time spent":"340.237316ms","remote":"127.0.0.1:54358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-27T02:45:26.442979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.247831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-27T02:45:26.443205Z","caller":"traceutil/trace.go:171","msg":"trace[879590918] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2217; }","duration":"341.460974ms","start":"2026-04-27T02:45:26.10172Z","end":"2026-04-27T02:45:26.443181Z","steps":["trace[879590918] 'agreement among raft nodes before linearized reading' (duration: 341.157179ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:26.442992Z","caller":"traceutil/trace.go:171","msg":"trace[1661819883] transaction","detail":"{read_only:false; response_revision:2217; number_of_response:1; }","duration":"175.225804ms","start":"2026-04-27T02:45:26.267748Z","end":"2026-04-27T02:45:26.442974Z","steps":["trace[1661819883] 'process raft request' (duration: 175.058021ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.443304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:26.101699Z","time spent":"341.566176ms","remote":"127.0.0.1:56314","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-04-27T02:45:26.443425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.851801ms","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":"warn","ts":"2026-04-27T02:45:26.443014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.006305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-27T02:45:26.44348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.741613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-27T02:45:26.443509Z","caller":"traceutil/trace.go:171","msg":"trace[1565078452] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2217; }","duration":"344.816945ms","start":"2026-04-27T02:45:26.098685Z","end":"2026-04-27T02:45:26.443502Z","steps":["trace[1565078452] 'agreement among raft nodes before linearized reading' (duration: 344.734523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.443541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:26.098654Z","time spent":"344.879615ms","remote":"127.0.0.1:56314","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-04-27T02:45:26.443418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.251486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-04-27T02:45:26.443631Z","caller":"traceutil/trace.go:171","msg":"trace[112221769] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2217; }","duration":"473.50594ms","start":"2026-04-27T02:45:25.970112Z","end":"2026-04-27T02:45:26.443618Z","steps":["trace[112221769] 'agreement among raft nodes before linearized reading' (duration: 473.125185ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.443605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.663617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-27T02:45:26.443698Z","caller":"traceutil/trace.go:171","msg":"trace[273727765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2217; }","duration":"447.783918ms","start":"2026-04-27T02:45:25.995903Z","end":"2026-04-27T02:45:26.443687Z","steps":["trace[273727765] 'agreement among raft nodes before linearized reading' (duration: 447.165589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.443729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.995889Z","time spent":"447.831839ms","remote":"127.0.0.1:56314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-27T02:45:26.443664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:25.970092Z","time spent":"473.562311ms","remote":"127.0.0.1:54358","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-27T02:45:26.443515Z","caller":"traceutil/trace.go:171","msg":"trace[1360401193] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2217; }","duration":"228.522762ms","start":"2026-04-27T02:45:26.214968Z","end":"2026-04-27T02:45:26.443491Z","steps":["trace[1360401193] 'agreement among raft nodes before linearized reading' (duration: 228.029625ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:45:26.444517Z","caller":"traceutil/trace.go:171","msg":"trace[411787747] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2217; }","duration":"364.986332ms","start":"2026-04-27T02:45:26.078499Z","end":"2026-04-27T02:45:26.443485Z","steps":["trace[411787747] 'agreement among raft nodes before linearized reading' (duration: 364.420194ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:26.44457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-27T02:45:26.078482Z","time spent":"366.073678ms","remote":"127.0.0.1:56314","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":"info","ts":"2026-04-27T02:45:45.183738Z","caller":"traceutil/trace.go:171","msg":"trace[1766586956] linearizableReadLoop","detail":"{readStateIndex:2480; appliedIndex:2479; }","duration":"106.581425ms","start":"2026-04-27T02:45:45.077135Z","end":"2026-04-27T02:45:45.183716Z","steps":["trace[1766586956] 'read index received' (duration: 106.368012ms)","trace[1766586956] 'applied index is now lower than readState.Index' (duration: 212.563µs)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:45:45.18385Z","caller":"traceutil/trace.go:171","msg":"trace[1785063260] transaction","detail":"{read_only:false; response_revision:2386; number_of_response:1; }","duration":"155.763954ms","start":"2026-04-27T02:45:45.028042Z","end":"2026-04-27T02:45:45.183806Z","steps":["trace[1785063260] 'process raft request' (duration: 155.524511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:45:45.183955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.791068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-ndv2c\" ","response":"range_response_count:1 size:5852"} {"level":"info","ts":"2026-04-27T02:45:45.183995Z","caller":"traceutil/trace.go:171","msg":"trace[746243246] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-cluster-operator-54f767cff8-ndv2c; range_end:; response_count:1; response_revision:2386; }","duration":"106.882539ms","start":"2026-04-27T02:45:45.077099Z","end":"2026-04-27T02:45:45.183981Z","steps":["trace[746243246] 'agreement among raft nodes before linearized reading' (duration: 106.716206ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:46:04.799535Z","caller":"traceutil/trace.go:171","msg":"trace[2147392760] transaction","detail":"{read_only:false; response_revision:2513; number_of_response:1; }","duration":"150.011377ms","start":"2026-04-27T02:46:04.649483Z","end":"2026-04-27T02:46:04.799495Z","steps":["trace[2147392760] 'process raft request' (duration: 149.868895ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:46:04.799577Z","caller":"traceutil/trace.go:171","msg":"trace[705080176] linearizableReadLoop","detail":"{readStateIndex:2612; appliedIndex:2612; }","duration":"117.341028ms","start":"2026-04-27T02:46:04.682198Z","end":"2026-04-27T02:46:04.799539Z","steps":["trace[705080176] 'read index received' (duration: 117.325058ms)","trace[705080176] 'applied index is now lower than readState.Index' (duration: 13.7µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:46:04.799907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.686962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-27T02:46:04.799952Z","caller":"traceutil/trace.go:171","msg":"trace[359325291] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2513; }","duration":"117.753113ms","start":"2026-04-27T02:46:04.682188Z","end":"2026-04-27T02:46:04.799941Z","steps":["trace[359325291] 'agreement among raft nodes before linearized reading' (duration: 117.48326ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:46:05.080798Z","caller":"traceutil/trace.go:171","msg":"trace[2117445000] linearizableReadLoop","detail":"{readStateIndex:2618; appliedIndex:2616; }","duration":"113.620196ms","start":"2026-04-27T02:46:04.967142Z","end":"2026-04-27T02:46:05.080763Z","steps":["trace[2117445000] 'read index received' (duration: 22.993609ms)","trace[2117445000] 'applied index is now lower than readState.Index' (duration: 90.624777ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:46:05.081255Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.097522ms","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-04-27T02:46:05.081468Z","caller":"traceutil/trace.go:171","msg":"trace[208822566] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2519; }","duration":"114.236534ms","start":"2026-04-27T02:46:04.967084Z","end":"2026-04-27T02:46:05.081321Z","steps":["trace[208822566] 'agreement among raft nodes before linearized reading' (duration: 113.850319ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:46:05.081637Z","caller":"traceutil/trace.go:171","msg":"trace[1746074142] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"135.420848ms","start":"2026-04-27T02:46:04.946198Z","end":"2026-04-27T02:46:05.081619Z","steps":["trace[1746074142] 'process raft request' (duration: 134.376914ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:47:01.200266Z","caller":"traceutil/trace.go:171","msg":"trace[820162082] linearizableReadLoop","detail":"{readStateIndex:3052; appliedIndex:3050; }","duration":"133.583565ms","start":"2026-04-27T02:47:01.066658Z","end":"2026-04-27T02:47:01.200242Z","steps":["trace[820162082] 'read index received' (duration: 65.031931ms)","trace[820162082] 'applied index is now lower than readState.Index' (duration: 68.550884ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:47:01.200329Z","caller":"traceutil/trace.go:171","msg":"trace[48807434] transaction","detail":"{read_only:false; response_revision:2938; number_of_response:1; }","duration":"137.832488ms","start":"2026-04-27T02:47:01.062462Z","end":"2026-04-27T02:47:01.200294Z","steps":["trace[48807434] 'process raft request' (duration: 137.635696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:47:01.200539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.847469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-27T02:47:01.200581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.110332ms","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-04-27T02:47:01.200581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.723137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-27T02:47:01.200609Z","caller":"traceutil/trace.go:171","msg":"trace[1192318882] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2938; }","duration":"133.924149ms","start":"2026-04-27T02:47:01.066642Z","end":"2026-04-27T02:47:01.200566Z","steps":["trace[1192318882] 'agreement among raft nodes before linearized reading' (duration: 133.734717ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:47:01.200647Z","caller":"traceutil/trace.go:171","msg":"trace[1987934023] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2938; }","duration":"130.213573ms","start":"2026-04-27T02:47:01.070417Z","end":"2026-04-27T02:47:01.20063Z","steps":["trace[1987934023] 'agreement among raft nodes before linearized reading' (duration: 130.026971ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:47:01.200652Z","caller":"traceutil/trace.go:171","msg":"trace[2102332202] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2938; }","duration":"133.840778ms","start":"2026-04-27T02:47:01.066797Z","end":"2026-04-27T02:47:01.200638Z","steps":["trace[2102332202] 'agreement among raft nodes before linearized reading' (duration: 133.627036ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:47:13.648056Z","caller":"traceutil/trace.go:171","msg":"trace[117123373] transaction","detail":"{read_only:false; response_revision:3040; number_of_response:1; }","duration":"112.131582ms","start":"2026-04-27T02:47:13.535898Z","end":"2026-04-27T02:47:13.64803Z","steps":["trace[117123373] 'process raft request' (duration: 74.124533ms)","trace[117123373] 'compare' (duration: 37.753077ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:47:47.583042Z","caller":"traceutil/trace.go:171","msg":"trace[353949209] transaction","detail":"{read_only:false; response_revision:3334; number_of_response:1; }","duration":"107.131083ms","start":"2026-04-27T02:47:47.475869Z","end":"2026-04-27T02:47:47.583Z","steps":["trace[353949209] 'process raft request' (duration: 106.620143ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:52:17.372422Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3063} {"level":"info","ts":"2026-04-27T02:52:17.47586Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3063,"took":"101.943545ms","hash":151786936,"current-db-size-bytes":38895616,"current-db-size":"39 MB","current-db-size-in-use-bytes":12681216,"current-db-size-in-use":"13 MB"} {"level":"info","ts":"2026-04-27T02:52:17.476042Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":151786936,"revision":3063,"compact-revision":-1} {"level":"info","ts":"2026-04-27T02:53:02.846016Z","caller":"traceutil/trace.go:171","msg":"trace[656984975] transaction","detail":"{read_only:false; response_revision:5577; number_of_response:1; }","duration":"258.626457ms","start":"2026-04-27T02:53:02.587372Z","end":"2026-04-27T02:53:02.845999Z","steps":["trace[656984975] 'process raft request' (duration: 258.516335ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:02.85001Z","caller":"traceutil/trace.go:171","msg":"trace[312257192] linearizableReadLoop","detail":"{readStateIndex:5782; appliedIndex:5780; }","duration":"220.301796ms","start":"2026-04-27T02:53:02.629689Z","end":"2026-04-27T02:53:02.84999Z","steps":["trace[312257192] 'read index received' (duration: 216.241463ms)","trace[312257192] 'applied index is now lower than readState.Index' (duration: 4.059063ms)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:53:02.850193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.451328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T02:53:02.850262Z","caller":"traceutil/trace.go:171","msg":"trace[2051231611] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:5580; }","duration":"220.597481ms","start":"2026-04-27T02:53:02.629644Z","end":"2026-04-27T02:53:02.850242Z","steps":["trace[2051231611] 'agreement among raft nodes before linearized reading' (duration: 220.431238ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:02.850435Z","caller":"traceutil/trace.go:171","msg":"trace[1962064714] transaction","detail":"{read_only:false; response_revision:5578; number_of_response:1; }","duration":"257.298433ms","start":"2026-04-27T02:53:02.593056Z","end":"2026-04-27T02:53:02.850354Z","steps":["trace[1962064714] 'process raft request' (duration: 256.750123ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:02.850522Z","caller":"traceutil/trace.go:171","msg":"trace[527117350] transaction","detail":"{read_only:false; response_revision:5579; number_of_response:1; }","duration":"202.957228ms","start":"2026-04-27T02:53:02.647549Z","end":"2026-04-27T02:53:02.850506Z","steps":["trace[527117350] 'process raft request' (duration: 202.361517ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:02.850687Z","caller":"traceutil/trace.go:171","msg":"trace[1659687166] transaction","detail":"{read_only:false; response_revision:5580; number_of_response:1; }","duration":"120.415051ms","start":"2026-04-27T02:53:02.73026Z","end":"2026-04-27T02:53:02.850675Z","steps":["trace[1659687166] 'process raft request' (duration: 119.689908ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:49.038357Z","caller":"traceutil/trace.go:171","msg":"trace[1106519561] transaction","detail":"{read_only:false; response_revision:6403; number_of_response:1; }","duration":"164.150521ms","start":"2026-04-27T02:53:48.874155Z","end":"2026-04-27T02:53:49.038306Z","steps":["trace[1106519561] 'process raft request' (duration: 125.171541ms)","trace[1106519561] 'compare' (duration: 38.809767ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:53:49.1614Z","caller":"traceutil/trace.go:171","msg":"trace[1627146374] linearizableReadLoop","detail":"{readStateIndex:6639; appliedIndex:6637; }","duration":"240.820408ms","start":"2026-04-27T02:53:48.920558Z","end":"2026-04-27T02:53:49.161379Z","steps":["trace[1627146374] 'read index received' (duration: 78.777694ms)","trace[1627146374] 'applied index is now lower than readState.Index' (duration: 162.041824ms)"],"step_count":2} {"level":"info","ts":"2026-04-27T02:53:49.161538Z","caller":"traceutil/trace.go:171","msg":"trace[696940984] transaction","detail":"{read_only:false; response_revision:6404; number_of_response:1; }","duration":"280.321436ms","start":"2026-04-27T02:53:48.881138Z","end":"2026-04-27T02:53:49.16146Z","steps":["trace[696940984] 'process raft request' (duration: 271.727358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:53:49.161636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.059022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-27T02:53:49.161689Z","caller":"traceutil/trace.go:171","msg":"trace[1404674603] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:6404; }","duration":"241.168674ms","start":"2026-04-27T02:53:48.920504Z","end":"2026-04-27T02:53:49.161672Z","steps":["trace[1404674603] 'agreement among raft nodes before linearized reading' (duration: 240.975181ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:49.193747Z","caller":"traceutil/trace.go:171","msg":"trace[927284405] transaction","detail":"{read_only:false; response_revision:6406; number_of_response:1; }","duration":"179.92016ms","start":"2026-04-27T02:53:49.013816Z","end":"2026-04-27T02:53:49.193736Z","steps":["trace[927284405] 'process raft request' (duration: 179.789728ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:49.193721Z","caller":"traceutil/trace.go:171","msg":"trace[2104972986] transaction","detail":"{read_only:false; response_revision:6405; number_of_response:1; }","duration":"180.642693ms","start":"2026-04-27T02:53:49.013052Z","end":"2026-04-27T02:53:49.193694Z","steps":["trace[2104972986] 'process raft request' (duration: 180.418739ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:53:49.194221Z","caller":"traceutil/trace.go:171","msg":"trace[165068115] transaction","detail":"{read_only:false; response_revision:6407; number_of_response:1; }","duration":"171.846471ms","start":"2026-04-27T02:53:49.022363Z","end":"2026-04-27T02:53:49.194209Z","steps":["trace[165068115] 'process raft request' (duration: 171.277292ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:54:11.659774Z","caller":"traceutil/trace.go:171","msg":"trace[333198209] linearizableReadLoop","detail":"{readStateIndex:6870; appliedIndex:6869; }","duration":"112.900985ms","start":"2026-04-27T02:54:11.546855Z","end":"2026-04-27T02:54:11.659756Z","steps":["trace[333198209] 'read index received' (duration: 112.710072ms)","trace[333198209] 'applied index is now lower than readState.Index' (duration: 190.373µs)"],"step_count":2} {"level":"warn","ts":"2026-04-27T02:54:11.660158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.256612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-27T02:54:11.660193Z","caller":"traceutil/trace.go:171","msg":"trace[185826128] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6626; }","duration":"113.362143ms","start":"2026-04-27T02:54:11.546815Z","end":"2026-04-27T02:54:11.660178Z","steps":["trace[185826128] 'agreement among raft nodes before linearized reading' (duration: 113.228321ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:54:11.660357Z","caller":"traceutil/trace.go:171","msg":"trace[1559210697] transaction","detail":"{read_only:false; response_revision:6626; number_of_response:1; }","duration":"119.025699ms","start":"2026-04-27T02:54:11.541289Z","end":"2026-04-27T02:54:11.660315Z","steps":["trace[1559210697] 'process raft request' (duration: 118.356938ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:54:11.806362Z","caller":"traceutil/trace.go:171","msg":"trace[1827958831] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6628; }","duration":"100.021146ms","start":"2026-04-27T02:54:11.706317Z","end":"2026-04-27T02:54:11.806339Z","steps":["trace[1827958831] 'agreement among raft nodes before linearized reading' (duration: 99.965276ms)"],"step_count":1} {"level":"info","ts":"2026-04-27T02:54:11.806589Z","caller":"traceutil/trace.go:171","msg":"trace[1922051523] transaction","detail":"{read_only:false; response_revision:6628; number_of_response:1; }","duration":"138.296766ms","start":"2026-04-27T02:54:11.668243Z","end":"2026-04-27T02:54:11.80654Z","steps":["trace[1922051523] 'process raft request' (duration: 137.650075ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:54:11.806829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.242381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/clienttrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-27T02:54:11.806941Z","caller":"traceutil/trace.go:171","msg":"trace[28144624] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/clienttrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/clienttrafficpolicies0; response_count:0; response_revision:6628; }","duration":"103.392814ms","start":"2026-04-27T02:54:11.703522Z","end":"2026-04-27T02:54:11.806915Z","steps":["trace[28144624] 'agreement among raft nodes before linearized reading' (duration: 103.242362ms)"],"step_count":1} {"level":"warn","ts":"2026-04-27T02:54:11.807679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.961391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" limit:500 ","response":"range_response_count:95 size:106689"} {"level":"info","ts":"2026-04-27T02:54:11.807823Z","caller":"traceutil/trace.go:171","msg":"trace[1812442122] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:95; response_revision:6628; }","duration":"128.137874ms","start":"2026-04-27T02:54:11.679663Z","end":"2026-04-27T02:54:11.807801Z","steps":["trace[1812442122] 'agreement among raft nodes before linearized reading' (duration: 127.174378ms)"],"step_count":1}