{"level":"warn","ts":"2026-04-23T09:43:45.082113Z","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-23T09:43:45.082244Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.146: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.146:2380","--initial-cluster=instance=https://199.19.213.146:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.146:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.146: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-23T09:43:45.082385Z","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-23T09:43:45.082416Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.146:2380"]} {"level":"info","ts":"2026-04-23T09:43:45.082465Z","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-23T09:43:45.083529Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.146:2379"]} {"level":"info","ts":"2026-04-23T09:43:45.0837Z","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.146:2380"],"listen-peer-urls":["https://199.19.213.146:2380"],"advertise-client-urls":["https://199.19.213.146:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.146:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.146: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-23T09:43:45.088414Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.321314ms"} {"level":"info","ts":"2026-04-23T09:43:45.101168Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c8e9c1aa9bb537b7","cluster-id":"933c0a8774274c15"} {"level":"info","ts":"2026-04-23T09:43:45.101286Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 switched to configuration voters=()"} {"level":"info","ts":"2026-04-23T09:43:45.101315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 became follower at term 0"} {"level":"info","ts":"2026-04-23T09:43:45.101338Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c8e9c1aa9bb537b7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-23T09:43:45.101353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 became follower at term 1"} {"level":"info","ts":"2026-04-23T09:43:45.101407Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 switched to configuration voters=(14477315415660115895)"} {"level":"warn","ts":"2026-04-23T09:43:45.109076Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-23T09:43:45.110227Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-23T09:43:45.111422Z","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-23T09:43:45.113907Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c8e9c1aa9bb537b7","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-23T09:43:45.114061Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c8e9c1aa9bb537b7","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-23T09:43:45.114315Z","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-23T09:43:45.114783Z","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-23T09:43:45.114806Z","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-23T09:43:45.115651Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 switched to configuration voters=(14477315415660115895)"} {"level":"info","ts":"2026-04-23T09:43:45.116164Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"933c0a8774274c15","local-member-id":"c8e9c1aa9bb537b7","added-peer-id":"c8e9c1aa9bb537b7","added-peer-peer-urls":["https://199.19.213.146:2380"]} {"level":"info","ts":"2026-04-23T09:43:45.118026Z","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-23T09:43:45.118362Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c8e9c1aa9bb537b7","initial-advertise-peer-urls":["https://199.19.213.146:2380"],"listen-peer-urls":["https://199.19.213.146:2380"],"advertise-client-urls":["https://199.19.213.146:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.146:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-23T09:43:45.118404Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-23T09:43:45.118617Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.146:2380"} {"level":"info","ts":"2026-04-23T09:43:45.118633Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.146:2380"} {"level":"info","ts":"2026-04-23T09:43:45.602386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 is starting a new election at term 1"} {"level":"info","ts":"2026-04-23T09:43:45.60249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-23T09:43:45.602518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 received MsgPreVoteResp from c8e9c1aa9bb537b7 at term 1"} {"level":"info","ts":"2026-04-23T09:43:45.602534Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 became candidate at term 2"} {"level":"info","ts":"2026-04-23T09:43:45.602542Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 received MsgVoteResp from c8e9c1aa9bb537b7 at term 2"} {"level":"info","ts":"2026-04-23T09:43:45.602553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c8e9c1aa9bb537b7 became leader at term 2"} {"level":"info","ts":"2026-04-23T09:43:45.602562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c8e9c1aa9bb537b7 elected leader c8e9c1aa9bb537b7 at term 2"} {"level":"info","ts":"2026-04-23T09:43:45.603779Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:43:45.605177Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c8e9c1aa9bb537b7","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.146:2379]}","request-path":"/0/members/c8e9c1aa9bb537b7/attributes","cluster-id":"933c0a8774274c15","publish-timeout":"7s"} {"level":"info","ts":"2026-04-23T09:43:45.60521Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T09:43:45.605292Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-23T09:43:45.605432Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-23T09:43:45.605547Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-23T09:43:45.606619Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"933c0a8774274c15","local-member-id":"c8e9c1aa9bb537b7","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:43:45.606707Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:43:45.606733Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-23T09:43:45.610972Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-23T09:43:45.612058Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.146:2379"} {"level":"warn","ts":"2026-04-23T09:43:50.034165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.496086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:43:50.034262Z","caller":"traceutil/trace.go:171","msg":"trace[176802202] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:0; response_revision:227; }","duration":"208.63309ms","start":"2026-04-23T09:43:49.825608Z","end":"2026-04-23T09:43:50.034241Z","steps":["trace[176802202] 'range keys from in-memory index tree' (duration: 208.391172ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:43:50.23423Z","caller":"traceutil/trace.go:171","msg":"trace[1978032072] transaction","detail":"{read_only:false; response_revision:228; number_of_response:1; }","duration":"194.352345ms","start":"2026-04-23T09:43:50.039857Z","end":"2026-04-23T09:43:50.234209Z","steps":["trace[1978032072] 'process raft request' (duration: 194.21909ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:43:50.554779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.346551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-04-23T09:43:50.554856Z","caller":"traceutil/trace.go:171","msg":"trace[1186347980] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:228; }","duration":"317.496607ms","start":"2026-04-23T09:43:50.23734Z","end":"2026-04-23T09:43:50.554836Z","steps":["trace[1186347980] 'range keys from in-memory index tree' (duration: 317.258178ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:43:50.554884Z","caller":"traceutil/trace.go:171","msg":"trace[320223559] transaction","detail":"{read_only:false; response_revision:229; number_of_response:1; }","duration":"313.930714ms","start":"2026-04-23T09:43:50.240931Z","end":"2026-04-23T09:43:50.554862Z","steps":["trace[320223559] 'process raft request' (duration: 313.80275ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:43:50.554892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:43:50.23732Z","time spent":"317.564869ms","remote":"127.0.0.1:57494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":240,"request content":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" "} {"level":"warn","ts":"2026-04-23T09:43:50.555357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:43:50.240917Z","time spent":"314.037278ms","remote":"127.0.0.1:57476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:43:51.19429Z","caller":"traceutil/trace.go:171","msg":"trace[15678459] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"106.349781ms","start":"2026-04-23T09:43:51.087913Z","end":"2026-04-23T09:43:51.194263Z","steps":["trace[15678459] 'process raft request' (duration: 49.707873ms)","trace[15678459] 'compare' (duration: 56.292026ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:43:51.367393Z","caller":"traceutil/trace.go:171","msg":"trace[1899344560] transaction","detail":"{read_only:false; response_revision:264; number_of_response:1; }","duration":"137.594614ms","start":"2026-04-23T09:43:51.229765Z","end":"2026-04-23T09:43:51.36736Z","steps":["trace[1899344560] 'process raft request' (duration: 64.175745ms)","trace[1899344560] 'marshal mvccpb.KeyValue' {req_type:put; key:/registry/serviceaccounts/kube-system/kube-proxy; req_size:167; } (duration: 73.033997ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:43:51.367527Z","caller":"traceutil/trace.go:171","msg":"trace[1153944382] linearizableReadLoop","detail":"{readStateIndex:277; appliedIndex:275; }","duration":"129.314752ms","start":"2026-04-23T09:43:51.238199Z","end":"2026-04-23T09:43:51.367513Z","steps":["trace[1153944382] 'read index received' (duration: 55.731877ms)","trace[1153944382] 'applied index is now lower than readState.Index' (duration: 73.581435ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:43:51.367425Z","caller":"traceutil/trace.go:171","msg":"trace[1253894393] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"124.447016ms","start":"2026-04-23T09:43:51.24295Z","end":"2026-04-23T09:43:51.367397Z","steps":["trace[1253894393] 'process raft request' (duration: 124.405955ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:43:51.367857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.082001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-04-23T09:43:51.367922Z","caller":"traceutil/trace.go:171","msg":"trace[774796937] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:266; }","duration":"138.182535ms","start":"2026-04-23T09:43:51.229719Z","end":"2026-04-23T09:43:51.367902Z","steps":["trace[774796937] 'agreement among raft nodes before linearized reading' (duration: 138.06053ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:43:51.367898Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.05547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4017"} {"level":"info","ts":"2026-04-23T09:43:51.367437Z","caller":"traceutil/trace.go:171","msg":"trace[21230091] transaction","detail":"{read_only:false; response_revision:265; number_of_response:1; }","duration":"137.313725ms","start":"2026-04-23T09:43:51.2301Z","end":"2026-04-23T09:43:51.367414Z","steps":["trace[21230091] 'process raft request' (duration: 137.136089ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:43:51.368092Z","caller":"traceutil/trace.go:171","msg":"trace[1096357696] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:266; }","duration":"138.260186ms","start":"2026-04-23T09:43:51.229809Z","end":"2026-04-23T09:43:51.36807Z","steps":["trace[1096357696] 'agreement among raft nodes before linearized reading' (duration: 137.860683ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:43:51.36844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.139664ms","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-04-23T09:43:51.368509Z","caller":"traceutil/trace.go:171","msg":"trace[460633329] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:266; }","duration":"126.263848ms","start":"2026-04-23T09:43:51.242214Z","end":"2026-04-23T09:43:51.368477Z","steps":["trace[460633329] 'agreement among raft nodes before linearized reading' (duration: 126.144174ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:44:17.647668Z","caller":"traceutil/trace.go:171","msg":"trace[625590957] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"114.115764ms","start":"2026-04-23T09:44:17.533534Z","end":"2026-04-23T09:44:17.64765Z","steps":["trace[625590957] 'process raft request' (duration: 114.012072ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:18.747517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"415.733791ms","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-04-23T09:44:18.747596Z","caller":"traceutil/trace.go:171","msg":"trace[1971813725] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:624; }","duration":"415.889566ms","start":"2026-04-23T09:44:18.331691Z","end":"2026-04-23T09:44:18.747581Z","steps":["trace[1971813725] 'range keys from in-memory index tree' (duration: 415.641829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:18.747625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:44:18.331675Z","time spent":"415.942847ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-23T09:44:35.022987Z","caller":"traceutil/trace.go:171","msg":"trace[1130116472] transaction","detail":"{read_only:false; response_revision:740; number_of_response:1; }","duration":"123.263709ms","start":"2026-04-23T09:44:34.899688Z","end":"2026-04-23T09:44:35.022952Z","steps":["trace[1130116472] 'process raft request' (duration: 123.054093ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:44:51.388089Z","caller":"traceutil/trace.go:171","msg":"trace[1737337927] linearizableReadLoop","detail":"{readStateIndex:955; appliedIndex:954; }","duration":"209.130416ms","start":"2026-04-23T09:44:51.178938Z","end":"2026-04-23T09:44:51.388068Z","steps":["trace[1737337927] 'read index received' (duration: 208.931461ms)","trace[1737337927] 'applied index is now lower than readState.Index' (duration: 198.095µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:44:51.388166Z","caller":"traceutil/trace.go:171","msg":"trace[1878017316] transaction","detail":"{read_only:false; response_revision:920; number_of_response:1; }","duration":"281.220477ms","start":"2026-04-23T09:44:51.106918Z","end":"2026-04-23T09:44:51.388139Z","steps":["trace[1878017316] 'process raft request' (duration: 281.017032ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:51.388246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.300419ms","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-23T09:44:51.388304Z","caller":"traceutil/trace.go:171","msg":"trace[583854578] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:920; }","duration":"209.389641ms","start":"2026-04-23T09:44:51.178903Z","end":"2026-04-23T09:44:51.388293Z","steps":["trace[583854578] 'agreement among raft nodes before linearized reading' (duration: 209.248918ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:44:51.9765Z","caller":"traceutil/trace.go:171","msg":"trace[147784915] transaction","detail":"{read_only:false; response_revision:923; number_of_response:1; }","duration":"147.754702ms","start":"2026-04-23T09:44:51.828712Z","end":"2026-04-23T09:44:51.976467Z","steps":["trace[147784915] 'process raft request' (duration: 147.548507ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:52.325847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.547701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T09:44:52.325926Z","caller":"traceutil/trace.go:171","msg":"trace[1163279596] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:924; }","duration":"144.676853ms","start":"2026-04-23T09:44:52.181233Z","end":"2026-04-23T09:44:52.325909Z","steps":["trace[1163279596] 'count revisions from in-memory index tree' (duration: 144.399998ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:56.945556Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.871874908s","expected-duration":"1s"} {"level":"info","ts":"2026-04-23T09:44:56.945927Z","caller":"traceutil/trace.go:171","msg":"trace[1815378760] transaction","detail":"{read_only:false; response_revision:932; number_of_response:1; }","duration":"2.872442151s","start":"2026-04-23T09:44:54.073467Z","end":"2026-04-23T09:44:56.94591Z","steps":["trace[1815378760] 'process raft request' (duration: 2.872333629s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:56.946044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:44:54.073444Z","time spent":"2.872542054s","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:44:57.029374Z","caller":"traceutil/trace.go:171","msg":"trace[2062838951] linearizableReadLoop","detail":"{readStateIndex:969; appliedIndex:967; }","duration":"153.22995ms","start":"2026-04-23T09:44:56.876126Z","end":"2026-04-23T09:44:57.029356Z","steps":["trace[2062838951] 'read index received' (duration: 70.267195ms)","trace[2062838951] 'applied index is now lower than readState.Index' (duration: 82.962065ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:44:57.029431Z","caller":"traceutil/trace.go:171","msg":"trace[28057110] transaction","detail":"{read_only:false; response_revision:933; number_of_response:1; }","duration":"2.501607062s","start":"2026-04-23T09:44:54.527792Z","end":"2026-04-23T09:44:57.029399Z","steps":["trace[28057110] 'process raft request' (duration: 2.501464028s)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:57.029508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.360764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:44:57.029537Z","caller":"traceutil/trace.go:171","msg":"trace[348452842] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:933; }","duration":"153.408615ms","start":"2026-04-23T09:44:56.876121Z","end":"2026-04-23T09:44:57.029529Z","steps":["trace[348452842] 'agreement among raft nodes before linearized reading' (duration: 153.341993ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:57.029726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.525767ms","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-23T09:44:57.029774Z","caller":"traceutil/trace.go:171","msg":"trace[137149080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:933; }","duration":"153.598509ms","start":"2026-04-23T09:44:56.876164Z","end":"2026-04-23T09:44:57.029762Z","steps":["trace[137149080] 'agreement among raft nodes before linearized reading' (duration: 153.434755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:57.029773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.646565ms","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-04-23T09:44:57.029824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.005038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:44:57.029844Z","caller":"traceutil/trace.go:171","msg":"trace[672278758] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:933; }","duration":"149.750757ms","start":"2026-04-23T09:44:56.880074Z","end":"2026-04-23T09:44:57.029825Z","steps":["trace[672278758] 'agreement among raft nodes before linearized reading' (duration: 149.566782ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:44:57.029858Z","caller":"traceutil/trace.go:171","msg":"trace[35762671] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:933; }","duration":"146.089459ms","start":"2026-04-23T09:44:56.883759Z","end":"2026-04-23T09:44:57.029848Z","steps":["trace[35762671] 'agreement among raft nodes before linearized reading' (duration: 145.988567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:57.029899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.798488ms","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-04-23T09:44:57.029921Z","caller":"traceutil/trace.go:171","msg":"trace[675249561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:933; }","duration":"149.848559ms","start":"2026-04-23T09:44:56.880066Z","end":"2026-04-23T09:44:57.029915Z","steps":["trace[675249561] 'agreement among raft nodes before linearized reading' (duration: 149.762747ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:57.029993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.793714ms","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-23T09:44:57.030041Z","caller":"traceutil/trace.go:171","msg":"trace[412071626] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:933; }","duration":"153.840455ms","start":"2026-04-23T09:44:56.876186Z","end":"2026-04-23T09:44:57.030027Z","steps":["trace[412071626] 'agreement among raft nodes before linearized reading' (duration: 153.760813ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:44:57.030222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:44:54.527771Z","time spent":"2.501727064s","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:46:24.765907Z","caller":"traceutil/trace.go:171","msg":"trace[144529128] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"105.853581ms","start":"2026-04-23T09:46:24.660038Z","end":"2026-04-23T09:46:24.765892Z","steps":["trace[144529128] 'process raft request' (duration: 105.81506ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:46:24.765945Z","caller":"traceutil/trace.go:171","msg":"trace[886125023] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"111.820047ms","start":"2026-04-23T09:46:24.65409Z","end":"2026-04-23T09:46:24.76591Z","steps":["trace[886125023] 'process raft request' (duration: 111.687015ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:47:05.634634Z","caller":"traceutil/trace.go:171","msg":"trace[2015300838] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"153.09229ms","start":"2026-04-23T09:47:05.481515Z","end":"2026-04-23T09:47:05.634608Z","steps":["trace[2015300838] 'process raft request' (duration: 152.898497ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:47:05.648619Z","caller":"traceutil/trace.go:171","msg":"trace[1831976672] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"164.351804ms","start":"2026-04-23T09:47:05.484232Z","end":"2026-04-23T09:47:05.648584Z","steps":["trace[1831976672] 'process raft request' (duration: 164.13755ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:08.194092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.422865ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:47:08.194191Z","caller":"traceutil/trace.go:171","msg":"trace[657247114] linearizableReadLoop","detail":"{readStateIndex:2291; appliedIndex:2290; }","duration":"275.571515ms","start":"2026-04-23T09:47:07.918607Z","end":"2026-04-23T09:47:08.194179Z","steps":["trace[657247114] 'read index received' (duration: 107.779112ms)","trace[657247114] 'applied index is now lower than readState.Index' (duration: 167.789113ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:47:08.194324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.515563ms","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-23T09:47:08.194351Z","caller":"traceutil/trace.go:171","msg":"trace[786178079] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2194; }","duration":"232.568724ms","start":"2026-04-23T09:47:07.961774Z","end":"2026-04-23T09:47:08.194343Z","steps":["trace[786178079] 'agreement among raft nodes before linearized reading' (duration: 232.471382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:08.194383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.754759ms","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-23T09:47:08.19446Z","caller":"traceutil/trace.go:171","msg":"trace[1939310742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2194; }","duration":"275.885831ms","start":"2026-04-23T09:47:07.91856Z","end":"2026-04-23T09:47:08.194445Z","steps":["trace[1939310742] 'agreement among raft nodes before linearized reading' (duration: 275.682127ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:47:08.19429Z","caller":"traceutil/trace.go:171","msg":"trace[1319217735] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"368.041549ms","start":"2026-04-23T09:47:07.826212Z","end":"2026-04-23T09:47:08.194254Z","steps":["trace[1319217735] 'process raft request' (duration: 200.244977ms)","trace[1319217735] 'compare' (duration: 167.325243ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:47:08.194397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.30769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-04-23T09:47:08.194575Z","caller":"traceutil/trace.go:171","msg":"trace[142768438] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2194; }","duration":"144.497824ms","start":"2026-04-23T09:47:08.050069Z","end":"2026-04-23T09:47:08.194566Z","steps":["trace[142768438] 'agreement among raft nodes before linearized reading' (duration: 144.195538ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:08.194528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.713865ms","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-04-23T09:47:08.194681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:07.826193Z","time spent":"368.365535ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:47:08.194779Z","caller":"traceutil/trace.go:171","msg":"trace[1532177662] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2194; }","duration":"225.988161ms","start":"2026-04-23T09:47:07.96878Z","end":"2026-04-23T09:47:08.194768Z","steps":["trace[1532177662] 'agreement among raft nodes before linearized reading' (duration: 225.494931ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:08.194708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.079266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:47:08.19501Z","caller":"traceutil/trace.go:171","msg":"trace[264294095] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2194; }","duration":"231.677977ms","start":"2026-04-23T09:47:07.963314Z","end":"2026-04-23T09:47:08.194992Z","steps":["trace[264294095] 'agreement among raft nodes before linearized reading' (duration: 231.098316ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:47:08.650766Z","caller":"traceutil/trace.go:171","msg":"trace[322829460] linearizableReadLoop","detail":"{readStateIndex:2296; appliedIndex:2295; }","duration":"209.730263ms","start":"2026-04-23T09:47:08.441013Z","end":"2026-04-23T09:47:08.650743Z","steps":["trace[322829460] 'read index received' (duration: 209.509488ms)","trace[322829460] 'applied index is now lower than readState.Index' (duration: 219.845µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:08.65093Z","caller":"traceutil/trace.go:171","msg":"trace[567470847] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"319.703545ms","start":"2026-04-23T09:47:08.331149Z","end":"2026-04-23T09:47:08.650853Z","steps":["trace[567470847] 'process raft request' (duration: 319.45784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:08.651046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.014278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-20c47127-d339-4c0a-9f1a-d2d98d767c86\" ","response":"range_response_count:1 size:3617"} {"level":"info","ts":"2026-04-23T09:47:08.651085Z","caller":"traceutil/trace.go:171","msg":"trace[275713243] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-20c47127-d339-4c0a-9f1a-d2d98d767c86; range_end:; response_count:1; response_revision:2199; }","duration":"210.09929ms","start":"2026-04-23T09:47:08.440974Z","end":"2026-04-23T09:47:08.651073Z","steps":["trace[275713243] 'agreement among raft nodes before linearized reading' (duration: 209.922097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:08.65123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:08.331124Z","time spent":"319.952169ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:47:09.097092Z","caller":"traceutil/trace.go:171","msg":"trace[2129914741] linearizableReadLoop","detail":"{readStateIndex:2297; appliedIndex:2296; }","duration":"419.699099ms","start":"2026-04-23T09:47:08.677365Z","end":"2026-04-23T09:47:09.097064Z","steps":["trace[2129914741] 'read index received' (duration: 419.577766ms)","trace[2129914741] 'applied index is now lower than readState.Index' (duration: 120.213µs)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:09.097137Z","caller":"traceutil/trace.go:171","msg":"trace[1750947680] transaction","detail":"{read_only:false; response_revision:2200; number_of_response:1; }","duration":"439.852009ms","start":"2026-04-23T09:47:08.657257Z","end":"2026-04-23T09:47:09.097109Z","steps":["trace[1750947680] 'process raft request' (duration: 439.639615ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:09.097243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.854563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-20c47127-d339-4c0a-9f1a-d2d98d767c86\" ","response":"range_response_count:1 size:3737"} {"level":"info","ts":"2026-04-23T09:47:09.097293Z","caller":"traceutil/trace.go:171","msg":"trace[991359349] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-20c47127-d339-4c0a-9f1a-d2d98d767c86; range_end:; response_count:1; response_revision:2200; }","duration":"419.951174ms","start":"2026-04-23T09:47:08.677328Z","end":"2026-04-23T09:47:09.097279Z","steps":["trace[991359349] 'agreement among raft nodes before linearized reading' (duration: 419.857762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:09.097343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:08.677309Z","time spent":"420.019836ms","remote":"127.0.0.1:57480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3761,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-20c47127-d339-4c0a-9f1a-d2d98d767c86\" "} {"level":"warn","ts":"2026-04-23T09:47:09.097441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:08.657238Z","time spent":"439.988982ms","remote":"127.0.0.1:57480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3722,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:47:09.134407Z","caller":"traceutil/trace.go:171","msg":"trace[460336078] transaction","detail":"{read_only:false; response_revision:2202; number_of_response:1; }","duration":"254.833922ms","start":"2026-04-23T09:47:08.879548Z","end":"2026-04-23T09:47:09.134382Z","steps":["trace[460336078] 'process raft request' (duration: 254.7369ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:09.134472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.063387ms","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-23T09:47:09.134535Z","caller":"traceutil/trace.go:171","msg":"trace[390805891] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2202; }","duration":"454.161618ms","start":"2026-04-23T09:47:08.680355Z","end":"2026-04-23T09:47:09.134517Z","steps":["trace[390805891] 'agreement among raft nodes before linearized reading' (duration: 453.977305ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:09.13461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:08.680341Z","time spent":"454.25985ms","remote":"127.0.0.1:47224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-23T09:47:09.134672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.39868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.146\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-23T09:47:09.134756Z","caller":"traceutil/trace.go:171","msg":"trace[2116231434] range","detail":"{range_begin:/registry/masterleases/199.19.213.146; range_end:; response_count:1; response_revision:2202; }","duration":"404.526612ms","start":"2026-04-23T09:47:08.730217Z","end":"2026-04-23T09:47:09.134744Z","steps":["trace[2116231434] 'agreement among raft nodes before linearized reading' (duration: 404.218197ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:09.134825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:08.730197Z","time spent":"404.621125ms","remote":"127.0.0.1:57356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":159,"request content":"key:\"/registry/masterleases/199.19.213.146\" "} {"level":"warn","ts":"2026-04-23T09:47:09.134853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.863625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a8f35b01075070\" ","response":"range_response_count:1 size:982"} {"level":"info","ts":"2026-04-23T09:47:09.134903Z","caller":"traceutil/trace.go:171","msg":"trace[1848316011] range","detail":"{range_begin:/registry/events/openstack/datadir-percona-xtradb-pxc-0.18a8f35b01075070; range_end:; response_count:1; response_revision:2202; }","duration":"208.945646ms","start":"2026-04-23T09:47:08.925945Z","end":"2026-04-23T09:47:09.13489Z","steps":["trace[1848316011] 'agreement among raft nodes before linearized reading' (duration: 208.470527ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:47:09.134871Z","caller":"traceutil/trace.go:171","msg":"trace[1134965208] transaction","detail":"{read_only:false; response_revision:2201; number_of_response:1; }","duration":"321.036089ms","start":"2026-04-23T09:47:08.813748Z","end":"2026-04-23T09:47:09.134784Z","steps":["trace[1134965208] 'process raft request' (duration: 310.380109ms)","trace[1134965208] 'compare' (duration: 10.045079ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:47:09.13521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:08.813729Z","time spent":"321.379855ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T09:47:40.82233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.336343ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:47:40.822485Z","caller":"traceutil/trace.go:171","msg":"trace[1236817075] transaction","detail":"{read_only:false; response_revision:2452; number_of_response:1; }","duration":"229.907733ms","start":"2026-04-23T09:47:40.59255Z","end":"2026-04-23T09:47:40.822457Z","steps":["trace[1236817075] 'process raft request' (duration: 55.359785ms)","trace[1236817075] 'compare' (duration: 174.137527ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:40.997263Z","caller":"traceutil/trace.go:171","msg":"trace[1347832814] linearizableReadLoop","detail":"{readStateIndex:2558; appliedIndex:2557; }","duration":"103.101123ms","start":"2026-04-23T09:47:40.89413Z","end":"2026-04-23T09:47:40.997232Z","steps":["trace[1347832814] 'read index received' (duration: 83.214583ms)","trace[1347832814] 'applied index is now lower than readState.Index' (duration: 19.88533ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:40.997345Z","caller":"traceutil/trace.go:171","msg":"trace[1170725698] transaction","detail":"{read_only:false; response_revision:2453; number_of_response:1; }","duration":"200.761399ms","start":"2026-04-23T09:47:40.796543Z","end":"2026-04-23T09:47:40.997304Z","steps":["trace[1170725698] 'process raft request' (duration: 180.88922ms)","trace[1170725698] 'compare' (duration: 19.679093ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:47:40.99751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.329539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:47:40.99758Z","caller":"traceutil/trace.go:171","msg":"trace[634293823] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:2453; }","duration":"103.469273ms","start":"2026-04-23T09:47:40.894095Z","end":"2026-04-23T09:47:40.997564Z","steps":["trace[634293823] 'agreement among raft nodes before linearized reading' (duration: 103.3324ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:47:42.01295Z","caller":"traceutil/trace.go:171","msg":"trace[1744407727] transaction","detail":"{read_only:false; response_revision:2456; number_of_response:1; }","duration":"135.539171ms","start":"2026-04-23T09:47:41.877381Z","end":"2026-04-23T09:47:42.012921Z","steps":["trace[1744407727] 'process raft request' (duration: 135.325575ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:42.492154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.534957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:47:42.492314Z","caller":"traceutil/trace.go:171","msg":"trace[949873365] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2456; }","duration":"251.714512ms","start":"2026-04-23T09:47:42.240533Z","end":"2026-04-23T09:47:42.492247Z","steps":["trace[949873365] 'count revisions from in-memory index tree' (duration: 251.427395ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:42.492316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.774037ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-23T09:47:42.492445Z","caller":"traceutil/trace.go:171","msg":"trace[2041383115] transaction","detail":"{read_only:false; response_revision:2457; number_of_response:1; }","duration":"234.41808ms","start":"2026-04-23T09:47:42.258Z","end":"2026-04-23T09:47:42.492418Z","steps":["trace[2041383115] 'process raft request' (duration: 130.429007ms)","trace[2041383115] 'compare' (duration: 103.52951ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:42.637457Z","caller":"traceutil/trace.go:171","msg":"trace[1223869908] linearizableReadLoop","detail":"{readStateIndex:2563; appliedIndex:2561; }","duration":"271.071454ms","start":"2026-04-23T09:47:42.366356Z","end":"2026-04-23T09:47:42.637428Z","steps":["trace[1223869908] 'read index received' (duration: 22.034158ms)","trace[1223869908] 'applied index is now lower than readState.Index' (duration: 249.036206ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:42.637489Z","caller":"traceutil/trace.go:171","msg":"trace[1122101158] transaction","detail":"{read_only:false; response_revision:2458; number_of_response:1; }","duration":"342.821078ms","start":"2026-04-23T09:47:42.294632Z","end":"2026-04-23T09:47:42.637453Z","steps":["trace[1122101158] 'process raft request' (duration: 341.425689ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:42.637654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:47:42.294608Z","time spent":"342.972792ms","remote":"127.0.0.1:57392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":805,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-23T09:47:42.637847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.492686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T09:47:42.637912Z","caller":"traceutil/trace.go:171","msg":"trace[2022110753] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:2458; }","duration":"271.609079ms","start":"2026-04-23T09:47:42.366289Z","end":"2026-04-23T09:47:42.637898Z","steps":["trace[2022110753] 'agreement among raft nodes before linearized reading' (duration: 271.248199ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:42.638269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.413958ms","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-23T09:47:42.63834Z","caller":"traceutil/trace.go:171","msg":"trace[1020061357] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2458; }","duration":"262.577722ms","start":"2026-04-23T09:47:42.375743Z","end":"2026-04-23T09:47:42.638321Z","steps":["trace[1020061357] 'agreement among raft nodes before linearized reading' (duration: 261.862892ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:42.6384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.635674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T09:47:42.638444Z","caller":"traceutil/trace.go:171","msg":"trace[2086236962] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:2458; }","duration":"116.719686ms","start":"2026-04-23T09:47:42.521713Z","end":"2026-04-23T09:47:42.638432Z","steps":["trace[2086236962] 'agreement among raft nodes before linearized reading' (duration: 116.639314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:42.638612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.880719ms","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-23T09:47:42.638664Z","caller":"traceutil/trace.go:171","msg":"trace[152361499] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2458; }","duration":"197.97129ms","start":"2026-04-23T09:47:42.440675Z","end":"2026-04-23T09:47:42.638646Z","steps":["trace[152361499] 'agreement among raft nodes before linearized reading' (duration: 197.806726ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:47:52.912357Z","caller":"traceutil/trace.go:171","msg":"trace[150353215] transaction","detail":"{read_only:false; response_revision:2537; number_of_response:1; }","duration":"188.736338ms","start":"2026-04-23T09:47:52.723582Z","end":"2026-04-23T09:47:52.912318Z","steps":["trace[150353215] 'process raft request' (duration: 115.709738ms)","trace[150353215] 'compare' (duration: 72.845645ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:52.928746Z","caller":"traceutil/trace.go:171","msg":"trace[1448686631] linearizableReadLoop","detail":"{readStateIndex:2645; appliedIndex:2643; }","duration":"145.67343ms","start":"2026-04-23T09:47:52.783053Z","end":"2026-04-23T09:47:52.928726Z","steps":["trace[1448686631] 'read index received' (duration: 56.276915ms)","trace[1448686631] 'applied index is now lower than readState.Index' (duration: 89.395575ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:47:52.928955Z","caller":"traceutil/trace.go:171","msg":"trace[792576974] transaction","detail":"{read_only:false; response_revision:2538; number_of_response:1; }","duration":"197.230914ms","start":"2026-04-23T09:47:52.73154Z","end":"2026-04-23T09:47:52.928771Z","steps":["trace[792576974] 'process raft request' (duration: 197.08951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:47:52.92901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.810845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:47:52.929215Z","caller":"traceutil/trace.go:171","msg":"trace[76736893] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2538; }","duration":"146.124043ms","start":"2026-04-23T09:47:52.782999Z","end":"2026-04-23T09:47:52.929123Z","steps":["trace[76736893] 'agreement among raft nodes before linearized reading' (duration: 145.812214ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.615766Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4014851013828207131,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-23T09:48:01.671012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.011285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-23T09:48:01.671052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"724.599014ms","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-23T09:48:01.67108Z","caller":"traceutil/trace.go:171","msg":"trace[1652390201] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2579; }","duration":"724.663826ms","start":"2026-04-23T09:48:00.946408Z","end":"2026-04-23T09:48:01.671072Z","steps":["trace[1652390201] 'range keys from in-memory index tree' (duration: 724.452031ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:48:01.67109Z","caller":"traceutil/trace.go:171","msg":"trace[1984510295] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:2579; }","duration":"707.122697ms","start":"2026-04-23T09:48:00.963942Z","end":"2026-04-23T09:48:01.671064Z","steps":["trace[1984510295] 'count revisions from in-memory index tree' (duration: 706.940253ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.671076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.158629ms","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-04-23T09:48:01.671121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:00.963926Z","time spent":"707.185319ms","remote":"127.0.0.1:57598","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":5,"response size":31,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"info","ts":"2026-04-23T09:48:01.671139Z","caller":"traceutil/trace.go:171","msg":"trace[856192116] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2579; }","duration":"681.259342ms","start":"2026-04-23T09:48:00.989865Z","end":"2026-04-23T09:48:01.671124Z","steps":["trace[856192116] 'range keys from in-memory index tree' (duration: 681.017816ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.67118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:00.989851Z","time spent":"681.318064ms","remote":"127.0.0.1:57562","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-04-23T09:48:01.671104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:00.946387Z","time spent":"724.711938ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T09:48:01.671352Z","caller":"traceutil/trace.go:171","msg":"trace[1367060807] transaction","detail":"{read_only:false; response_revision:2580; number_of_response:1; }","duration":"582.418919ms","start":"2026-04-23T09:48:01.088926Z","end":"2026-04-23T09:48:01.671345Z","steps":["trace[1367060807] 'process raft request' (duration: 581.874434ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.671421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:01.088902Z","time spent":"582.481631ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:48:01.673685Z","caller":"traceutil/trace.go:171","msg":"trace[1622592695] linearizableReadLoop","detail":"{readStateIndex:2691; appliedIndex:2688; }","duration":"561.1524ms","start":"2026-04-23T09:48:01.112515Z","end":"2026-04-23T09:48:01.673667Z","steps":["trace[1622592695] 'read index received' (duration: 558.361754ms)","trace[1622592695] 'applied index is now lower than readState.Index' (duration: 2.789866ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:48:01.673784Z","caller":"traceutil/trace.go:171","msg":"trace[1342064396] transaction","detail":"{read_only:false; response_revision:2581; number_of_response:1; }","duration":"212.693362ms","start":"2026-04-23T09:48:01.461081Z","end":"2026-04-23T09:48:01.673774Z","steps":["trace[1342064396] 'process raft request' (duration: 212.418174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.673899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.377796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-23T09:48:01.673926Z","caller":"traceutil/trace.go:171","msg":"trace[59499825] transaction","detail":"{read_only:false; response_revision:2582; number_of_response:1; }","duration":"169.116394ms","start":"2026-04-23T09:48:01.504796Z","end":"2026-04-23T09:48:01.673913Z","steps":["trace[59499825] 'process raft request' (duration: 168.842607ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:48:01.673935Z","caller":"traceutil/trace.go:171","msg":"trace[1334549108] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:2582; }","duration":"561.471319ms","start":"2026-04-23T09:48:01.112455Z","end":"2026-04-23T09:48:01.673926Z","steps":["trace[1334549108] 'agreement among raft nodes before linearized reading' (duration: 561.386516ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:01.673995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:01.112432Z","time spent":"561.52004ms","remote":"127.0.0.1:57418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":29,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-04-23T09:48:01.674107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.754249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12383"} {"level":"info","ts":"2026-04-23T09:48:01.674189Z","caller":"traceutil/trace.go:171","msg":"trace[1282891459] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2582; }","duration":"264.882253ms","start":"2026-04-23T09:48:01.40929Z","end":"2026-04-23T09:48:01.674173Z","steps":["trace[1282891459] 'agreement among raft nodes before linearized reading' (duration: 264.615605ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:48:14.12745Z","caller":"traceutil/trace.go:171","msg":"trace[190354223] transaction","detail":"{read_only:false; response_revision:2649; number_of_response:1; }","duration":"389.902585ms","start":"2026-04-23T09:48:13.73753Z","end":"2026-04-23T09:48:14.127432Z","steps":["trace[190354223] 'process raft request' (duration: 354.671392ms)","trace[190354223] 'compare' (duration: 34.555155ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:48:14.127506Z","caller":"traceutil/trace.go:171","msg":"trace[1026453585] transaction","detail":"{read_only:false; response_revision:2650; number_of_response:1; }","duration":"388.041586ms","start":"2026-04-23T09:48:13.739441Z","end":"2026-04-23T09:48:14.127483Z","steps":["trace[1026453585] 'process raft request' (duration: 387.742448ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:14.127589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:13.737508Z","time spent":"390.021228ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-23T09:48:14.127621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:13.739431Z","time spent":"388.125258ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-23T09:48:14.127738Z","caller":"traceutil/trace.go:171","msg":"trace[1468758729] linearizableReadLoop","detail":"{readStateIndex:2761; appliedIndex:2759; }","duration":"318.809969ms","start":"2026-04-23T09:48:13.808421Z","end":"2026-04-23T09:48:14.127231Z","steps":["trace[1468758729] 'read index received' (duration: 283.656309ms)","trace[1468758729] 'applied index is now lower than readState.Index' (duration: 35.15277ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:48:14.128092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.656321ms","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-04-23T09:48:14.128161Z","caller":"traceutil/trace.go:171","msg":"trace[1514204150] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2650; }","duration":"319.763654ms","start":"2026-04-23T09:48:13.808382Z","end":"2026-04-23T09:48:14.128146Z","steps":["trace[1514204150] 'agreement among raft nodes before linearized reading' (duration: 319.175289ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:14.128195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:13.808368Z","time spent":"319.819077ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-23T09:48:14.302234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.969294ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-23T09:48:14.302566Z","caller":"traceutil/trace.go:171","msg":"trace[347377421] linearizableReadLoop","detail":"{readStateIndex:2762; appliedIndex:2761; }","duration":"174.781136ms","start":"2026-04-23T09:48:14.12776Z","end":"2026-04-23T09:48:14.302541Z","steps":["trace[347377421] 'read index received' (duration: 31.429432ms)","trace[347377421] 'applied index is now lower than readState.Index' (duration: 143.349684ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:48:14.302714Z","caller":"traceutil/trace.go:171","msg":"trace[500550155] transaction","detail":"{read_only:false; response_revision:2652; number_of_response:1; }","duration":"170.543194ms","start":"2026-04-23T09:48:14.132152Z","end":"2026-04-23T09:48:14.302696Z","steps":["trace[500550155] 'process raft request' (duration: 170.459152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:14.302789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.031795ms","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-23T09:48:14.30282Z","caller":"traceutil/trace.go:171","msg":"trace[1298331042] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2652; }","duration":"434.101757ms","start":"2026-04-23T09:48:13.868708Z","end":"2026-04-23T09:48:14.30281Z","steps":["trace[1298331042] 'agreement among raft nodes before linearized reading' (duration: 433.950703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:14.302841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:13.868691Z","time spent":"434.144519ms","remote":"127.0.0.1:47224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-04-23T09:48:14.303145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.466174ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:48:14.303178Z","caller":"traceutil/trace.go:171","msg":"trace[41637909] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:2652; }","duration":"127.530436ms","start":"2026-04-23T09:48:14.175639Z","end":"2026-04-23T09:48:14.30317Z","steps":["trace[41637909] 'agreement among raft nodes before linearized reading' (duration: 127.467354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:14.303186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.498896ms","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-23T09:48:14.303235Z","caller":"traceutil/trace.go:171","msg":"trace[528115303] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2652; }","duration":"492.575518ms","start":"2026-04-23T09:48:13.810652Z","end":"2026-04-23T09:48:14.303227Z","steps":["trace[528115303] 'agreement among raft nodes before linearized reading' (duration: 492.477916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:48:14.30326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-23T09:48:13.810637Z","time spent":"492.617599ms","remote":"127.0.0.1:57562","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-23T09:48:14.303547Z","caller":"traceutil/trace.go:171","msg":"trace[769172878] transaction","detail":"{read_only:false; response_revision:2651; number_of_response:1; }","duration":"172.254979ms","start":"2026-04-23T09:48:14.131278Z","end":"2026-04-23T09:48:14.303533Z","steps":["trace[769172878] 'process raft request' (duration: 171.102219ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:49:07.369193Z","caller":"traceutil/trace.go:171","msg":"trace[323286999] transaction","detail":"{read_only:false; response_revision:2993; number_of_response:1; }","duration":"209.207672ms","start":"2026-04-23T09:49:07.159962Z","end":"2026-04-23T09:49:07.36917Z","steps":["trace[323286999] 'process raft request' (duration: 209.087159ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:49:07.369795Z","caller":"traceutil/trace.go:171","msg":"trace[2010004450] linearizableReadLoop","detail":"{readStateIndex:3116; appliedIndex:3116; }","duration":"197.320006ms","start":"2026-04-23T09:49:07.172443Z","end":"2026-04-23T09:49:07.369763Z","steps":["trace[2010004450] 'read index received' (duration: 197.314116ms)","trace[2010004450] 'applied index is now lower than readState.Index' (duration: 4.77µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:49:07.369972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.583893ms","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-04-23T09:49:07.370005Z","caller":"traceutil/trace.go:171","msg":"trace[612940690] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2993; }","duration":"192.650904ms","start":"2026-04-23T09:49:07.177343Z","end":"2026-04-23T09:49:07.369994Z","steps":["trace[612940690] 'agreement among raft nodes before linearized reading' (duration: 192.525691ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:07.370296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.692686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-04-23T09:49:07.370341Z","caller":"traceutil/trace.go:171","msg":"trace[209436960] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2993; }","duration":"101.774268ms","start":"2026-04-23T09:49:07.268554Z","end":"2026-04-23T09:49:07.370328Z","steps":["trace[209436960] 'agreement among raft nodes before linearized reading' (duration: 101.613304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:07.370446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.976671ms","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-23T09:49:07.370613Z","caller":"traceutil/trace.go:171","msg":"trace[450597144] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2993; }","duration":"198.170696ms","start":"2026-04-23T09:49:07.172391Z","end":"2026-04-23T09:49:07.370562Z","steps":["trace[450597144] 'agreement among raft nodes before linearized reading' (duration: 197.683034ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:49:42.884471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.100601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:49:42.884886Z","caller":"traceutil/trace.go:171","msg":"trace[1455404085] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:3188; }","duration":"102.259644ms","start":"2026-04-23T09:49:42.782302Z","end":"2026-04-23T09:49:42.884561Z","steps":["trace[1455404085] 'count revisions from in-memory index tree' (duration: 102.001759ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:49:43.271702Z","caller":"traceutil/trace.go:171","msg":"trace[349436223] transaction","detail":"{read_only:false; response_revision:3190; number_of_response:1; }","duration":"216.233212ms","start":"2026-04-23T09:49:43.055452Z","end":"2026-04-23T09:49:43.271686Z","steps":["trace[349436223] 'process raft request' (duration: 190.063482ms)","trace[349436223] 'compare' (duration: 25.584006ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:52:37.255507Z","caller":"traceutil/trace.go:171","msg":"trace[1394154545] transaction","detail":"{read_only:false; response_revision:4432; number_of_response:1; }","duration":"114.869339ms","start":"2026-04-23T09:52:37.140566Z","end":"2026-04-23T09:52:37.255435Z","steps":["trace[1394154545] 'process raft request' (duration: 114.711095ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:37.109999Z","caller":"traceutil/trace.go:171","msg":"trace[1338044263] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"159.997389ms","start":"2026-04-23T09:53:36.949977Z","end":"2026-04-23T09:53:37.109975Z","steps":["trace[1338044263] 'process raft request' (duration: 102.835279ms)","trace[1338044263] 'compare' (duration: 56.963716ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:53:37.110095Z","caller":"traceutil/trace.go:171","msg":"trace[883967536] linearizableReadLoop","detail":"{readStateIndex:5673; appliedIndex:5672; }","duration":"146.320427ms","start":"2026-04-23T09:53:36.963764Z","end":"2026-04-23T09:53:37.110084Z","steps":["trace[883967536] 'read index received' (duration: 89.045135ms)","trace[883967536] 'applied index is now lower than readState.Index' (duration: 57.274342ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:53:37.110157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.374678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:53:37.111376Z","caller":"traceutil/trace.go:171","msg":"trace[2050786486] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5466; }","duration":"147.634762ms","start":"2026-04-23T09:53:36.963731Z","end":"2026-04-23T09:53:37.111366Z","steps":["trace[2050786486] 'agreement among raft nodes before linearized reading' (duration: 146.386017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-23T09:53:37.111399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.643634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:53:37.111431Z","caller":"traceutil/trace.go:171","msg":"trace[692646467] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:5466; }","duration":"139.707384ms","start":"2026-04-23T09:53:36.971716Z","end":"2026-04-23T09:53:37.111423Z","steps":["trace[692646467] 'agreement among raft nodes before linearized reading' (duration: 139.645533ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:43.805673Z","caller":"traceutil/trace.go:171","msg":"trace[594728705] linearizableReadLoop","detail":"{readStateIndex:5772; appliedIndex:5771; }","duration":"124.175051ms","start":"2026-04-23T09:53:43.681472Z","end":"2026-04-23T09:53:43.805647Z","steps":["trace[594728705] 'read index received' (duration: 108.53748ms)","trace[594728705] 'applied index is now lower than readState.Index' (duration: 15.636331ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:53:43.806124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.63177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-23T09:53:43.806178Z","caller":"traceutil/trace.go:171","msg":"trace[11434396] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5559; }","duration":"124.718893ms","start":"2026-04-23T09:53:43.681441Z","end":"2026-04-23T09:53:43.806159Z","steps":["trace[11434396] 'agreement among raft nodes before linearized reading' (duration: 124.553569ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:43.806823Z","caller":"traceutil/trace.go:171","msg":"trace[1643107809] transaction","detail":"{read_only:false; response_revision:5559; number_of_response:1; }","duration":"153.392923ms","start":"2026-04-23T09:53:43.653408Z","end":"2026-04-23T09:53:43.806801Z","steps":["trace[1643107809] 'process raft request' (duration: 136.62945ms)","trace[1643107809] 'compare' (duration: 15.392606ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:53:43.94697Z","caller":"traceutil/trace.go:171","msg":"trace[1761259040] transaction","detail":"{read_only:false; response_revision:5560; number_of_response:1; }","duration":"135.096359ms","start":"2026-04-23T09:53:43.811846Z","end":"2026-04-23T09:53:43.946942Z","steps":["trace[1761259040] 'process raft request' (duration: 129.361705ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:43.946965Z","caller":"traceutil/trace.go:171","msg":"trace[144833369] linearizableReadLoop","detail":"{readStateIndex:5773; appliedIndex:5772; }","duration":"132.65948ms","start":"2026-04-23T09:53:43.814272Z","end":"2026-04-23T09:53:43.946931Z","steps":["trace[144833369] 'read index received' (duration: 126.838495ms)","trace[144833369] 'applied index is now lower than readState.Index' (duration: 5.818655ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:53:43.947175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.897765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-04-23T09:53:43.947244Z","caller":"traceutil/trace.go:171","msg":"trace[38900359] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5560; }","duration":"133.051588ms","start":"2026-04-23T09:53:43.814179Z","end":"2026-04-23T09:53:43.947231Z","steps":["trace[38900359] 'agreement among raft nodes before linearized reading' (duration: 132.786943ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:44.608087Z","caller":"traceutil/trace.go:171","msg":"trace[2076523881] transaction","detail":"{read_only:false; response_revision:5564; number_of_response:1; }","duration":"111.139682ms","start":"2026-04-23T09:53:44.496924Z","end":"2026-04-23T09:53:44.608064Z","steps":["trace[2076523881] 'process raft request' (duration: 110.996279ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:44.608596Z","caller":"traceutil/trace.go:171","msg":"trace[1180752491] linearizableReadLoop","detail":"{readStateIndex:5778; appliedIndex:5778; }","duration":"107.487659ms","start":"2026-04-23T09:53:44.50101Z","end":"2026-04-23T09:53:44.608497Z","steps":["trace[1180752491] 'read index received' (duration: 107.176633ms)","trace[1180752491] 'applied index is now lower than readState.Index' (duration: 308.346µs)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:53:44.60868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.657462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-23T09:53:44.608764Z","caller":"traceutil/trace.go:171","msg":"trace[416444548] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5564; }","duration":"107.771845ms","start":"2026-04-23T09:53:44.500979Z","end":"2026-04-23T09:53:44.608751Z","steps":["trace[416444548] 'agreement among raft nodes before linearized reading' (duration: 107.600482ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:45.64297Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2823} {"level":"info","ts":"2026-04-23T09:53:45.748281Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2823,"took":"103.823375ms","hash":345650592,"current-db-size-bytes":54915072,"current-db-size":"55 MB","current-db-size-in-use-bytes":30818304,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-23T09:53:45.748344Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":345650592,"revision":2823,"compact-revision":-1} {"level":"warn","ts":"2026-04-23T09:53:46.565042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.644742ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-23T09:53:46.565134Z","caller":"traceutil/trace.go:171","msg":"trace[1277728812] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5597; }","duration":"102.745304ms","start":"2026-04-23T09:53:46.462376Z","end":"2026-04-23T09:53:46.565122Z","steps":["trace[1277728812] 'range keys from in-memory index tree' (duration: 102.583751ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:46.565385Z","caller":"traceutil/trace.go:171","msg":"trace[74100841] transaction","detail":"{read_only:false; response_revision:5598; number_of_response:1; }","duration":"128.156699ms","start":"2026-04-23T09:53:46.437197Z","end":"2026-04-23T09:53:46.565354Z","steps":["trace[74100841] 'process raft request' (duration: 69.090914ms)","trace[74100841] 'compare' (duration: 58.627666ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:53:49.645427Z","caller":"traceutil/trace.go:171","msg":"trace[509157809] linearizableReadLoop","detail":"{readStateIndex:5842; appliedIndex:5841; }","duration":"180.202312ms","start":"2026-04-23T09:53:49.465205Z","end":"2026-04-23T09:53:49.645408Z","steps":["trace[509157809] 'read index received' (duration: 120.673628ms)","trace[509157809] 'applied index is now lower than readState.Index' (duration: 59.525314ms)"],"step_count":2} {"level":"info","ts":"2026-04-23T09:53:49.645516Z","caller":"traceutil/trace.go:171","msg":"trace[1483384114] transaction","detail":"{read_only:false; response_revision:5626; number_of_response:1; }","duration":"248.697614ms","start":"2026-04-23T09:53:49.396809Z","end":"2026-04-23T09:53:49.645507Z","steps":["trace[1483384114] 'process raft request' (duration: 188.851764ms)","trace[1483384114] 'compare' (duration: 58.228278ms)"],"step_count":2} {"level":"warn","ts":"2026-04-23T09:53:49.64569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.486858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:1128"} {"level":"info","ts":"2026-04-23T09:53:49.645903Z","caller":"traceutil/trace.go:171","msg":"trace[1894992036] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:5626; }","duration":"180.56496ms","start":"2026-04-23T09:53:49.46514Z","end":"2026-04-23T09:53:49.645705Z","steps":["trace[1894992036] 'agreement among raft nodes before linearized reading' (duration: 180.453478ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:49.647354Z","caller":"traceutil/trace.go:171","msg":"trace[1677834489] transaction","detail":"{read_only:false; response_revision:5628; number_of_response:1; }","duration":"118.584728ms","start":"2026-04-23T09:53:49.528729Z","end":"2026-04-23T09:53:49.647313Z","steps":["trace[1677834489] 'process raft request' (duration: 118.146709ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:49.647495Z","caller":"traceutil/trace.go:171","msg":"trace[400961212] transaction","detail":"{read_only:false; response_revision:5627; number_of_response:1; }","duration":"178.155262ms","start":"2026-04-23T09:53:49.469316Z","end":"2026-04-23T09:53:49.647471Z","steps":["trace[400961212] 'process raft request' (duration: 177.403637ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:53:49.647658Z","caller":"traceutil/trace.go:171","msg":"trace[572667847] transaction","detail":"{read_only:false; number_of_response:1; response_revision:5627; }","duration":"176.789815ms","start":"2026-04-23T09:53:49.470841Z","end":"2026-04-23T09:53:49.647631Z","steps":["trace[572667847] 'process raft request' (duration: 175.999029ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:56:21.848627Z","caller":"traceutil/trace.go:171","msg":"trace[1734752377] transaction","detail":"{read_only:false; response_revision:6746; number_of_response:1; }","duration":"119.011024ms","start":"2026-04-23T09:56:21.729585Z","end":"2026-04-23T09:56:21.848596Z","steps":["trace[1734752377] 'process raft request' (duration: 118.82289ms)"],"step_count":1} {"level":"info","ts":"2026-04-23T09:56:21.853552Z","caller":"traceutil/trace.go:171","msg":"trace[1908868105] transaction","detail":"{read_only:false; response_revision:6747; number_of_response:1; }","duration":"123.932639ms","start":"2026-04-23T09:56:21.729599Z","end":"2026-04-23T09:56:21.853532Z","steps":["trace[1908868105] 'process raft request' (duration: 123.524441ms)"],"step_count":1}