{"level":"warn","ts":"2026-04-28T07:18:56.988072Z","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-28T07:18:56.988165Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.196: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.196:2380","--initial-cluster=instance=https://199.19.213.196:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.196:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.196: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-28T07:18:56.988228Z","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-28T07:18:56.988237Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.196:2380"]} {"level":"info","ts":"2026-04-28T07:18:56.988254Z","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-28T07:18:56.98901Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"]} {"level":"info","ts":"2026-04-28T07:18:56.989094Z","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.196:2380"],"listen-peer-urls":["https://199.19.213.196:2380"],"advertise-client-urls":["https://199.19.213.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.196: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-28T07:18:56.994Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.689295ms"} {"level":"info","ts":"2026-04-28T07:18:57.002174Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8f376d4d42da413a","cluster-id":"f5ef03c8da56d984"} {"level":"info","ts":"2026-04-28T07:18:57.002264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T07:18:57.002292Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became follower at term 0"} {"level":"info","ts":"2026-04-28T07:18:57.002306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8f376d4d42da413a [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T07:18:57.002322Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became follower at term 1"} {"level":"info","ts":"2026-04-28T07:18:57.002363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=(10319837249744290106)"} {"level":"warn","ts":"2026-04-28T07:18:57.014864Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T07:18:57.016692Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T07:18:57.017977Z","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-28T07:18:57.021042Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8f376d4d42da413a","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T07:18:57.021327Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8f376d4d42da413a","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T07:18:57.021539Z","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-28T07:18:57.021659Z","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-28T07:18:57.021678Z","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-28T07:18:57.022728Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a switched to configuration voters=(10319837249744290106)"} {"level":"info","ts":"2026-04-28T07:18:57.023782Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f5ef03c8da56d984","local-member-id":"8f376d4d42da413a","added-peer-id":"8f376d4d42da413a","added-peer-peer-urls":["https://199.19.213.196:2380"]} {"level":"info","ts":"2026-04-28T07:18:57.026556Z","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-28T07:18:57.026702Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.196:2380"} {"level":"info","ts":"2026-04-28T07:18:57.026746Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8f376d4d42da413a","initial-advertise-peer-urls":["https://199.19.213.196:2380"],"listen-peer-urls":["https://199.19.213.196:2380"],"advertise-client-urls":["https://199.19.213.196:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.196:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T07:18:57.026768Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.196:2380"} {"level":"info","ts":"2026-04-28T07:18:57.026805Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T07:18:57.903235Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T07:18:57.903305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T07:18:57.903336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a received MsgPreVoteResp from 8f376d4d42da413a at term 1"} {"level":"info","ts":"2026-04-28T07:18:57.903351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became candidate at term 2"} {"level":"info","ts":"2026-04-28T07:18:57.90336Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a received MsgVoteResp from 8f376d4d42da413a at term 2"} {"level":"info","ts":"2026-04-28T07:18:57.903371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8f376d4d42da413a became leader at term 2"} {"level":"info","ts":"2026-04-28T07:18:57.903381Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8f376d4d42da413a elected leader 8f376d4d42da413a at term 2"} {"level":"info","ts":"2026-04-28T07:18:57.904175Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:18:57.905151Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8f376d4d42da413a","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.196:2379]}","request-path":"/0/members/8f376d4d42da413a/attributes","cluster-id":"f5ef03c8da56d984","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T07:18:57.905355Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T07:18:57.905414Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T07:18:57.905655Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f5ef03c8da56d984","local-member-id":"8f376d4d42da413a","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:18:57.905766Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:18:57.905801Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T07:18:57.909278Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T07:18:57.909437Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.196:2379"} {"level":"info","ts":"2026-04-28T07:18:57.913626Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T07:18:57.913656Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T07:19:30.956573Z","caller":"traceutil/trace.go:171","msg":"trace[1332707967] transaction","detail":"{read_only:false; response_revision:440; number_of_response:1; }","duration":"106.125177ms","start":"2026-04-28T07:19:30.850425Z","end":"2026-04-28T07:19:30.956551Z","steps":["trace[1332707967] 'process raft request' (duration: 68.519961ms)","trace[1332707967] 'compare' (duration: 37.444652ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:19:32.440022Z","caller":"traceutil/trace.go:171","msg":"trace[1443610266] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"125.697845ms","start":"2026-04-28T07:19:32.314306Z","end":"2026-04-28T07:19:32.440004Z","steps":["trace[1443610266] 'process raft request' (duration: 125.548562ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:19:35.214894Z","caller":"traceutil/trace.go:171","msg":"trace[410418322] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"170.159191ms","start":"2026-04-28T07:19:35.044701Z","end":"2026-04-28T07:19:35.21486Z","steps":["trace[410418322] 'process raft request' (duration: 169.902925ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:19:39.736819Z","caller":"traceutil/trace.go:171","msg":"trace[561307720] transaction","detail":"{read_only:false; response_revision:586; number_of_response:1; }","duration":"100.887753ms","start":"2026-04-28T07:19:39.63588Z","end":"2026-04-28T07:19:39.736767Z","steps":["trace[561307720] 'process raft request' (duration: 99.93463ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:19:40.30381Z","caller":"traceutil/trace.go:171","msg":"trace[742622565] linearizableReadLoop","detail":"{readStateIndex:608; appliedIndex:607; }","duration":"466.545876ms","start":"2026-04-28T07:19:39.837236Z","end":"2026-04-28T07:19:40.303782Z","steps":["trace[742622565] 'read index received' (duration: 425.348817ms)","trace[742622565] 'applied index is now lower than readState.Index' (duration: 41.195779ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:19:40.303915Z","caller":"traceutil/trace.go:171","msg":"trace[1268954299] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"494.093516ms","start":"2026-04-28T07:19:39.809756Z","end":"2026-04-28T07:19:40.30385Z","steps":["trace[1268954299] 'process raft request' (duration: 452.818715ms)","trace[1268954299] 'compare' (duration: 40.82974ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:19:40.304104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"466.850574ms","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-28T07:19:40.304185Z","caller":"traceutil/trace.go:171","msg":"trace[1035553475] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:589; }","duration":"466.973427ms","start":"2026-04-28T07:19:39.837197Z","end":"2026-04-28T07:19:40.304171Z","steps":["trace[1035553475] 'agreement among raft nodes before linearized reading' (duration: 466.727471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:19:40.304219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:19:39.837179Z","time spent":"467.031329ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T07:19:40.304402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.100465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-vrsdk\" ","response":"range_response_count:1 size:16965"} {"level":"warn","ts":"2026-04-28T07:19:40.304377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.804246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:19:40.304449Z","caller":"traceutil/trace.go:171","msg":"trace[432452686] range","detail":"{range_begin:/registry/pods/kube-system/cilium-vrsdk; range_end:; response_count:1; response_revision:589; }","duration":"429.175537ms","start":"2026-04-28T07:19:39.875259Z","end":"2026-04-28T07:19:40.304435Z","steps":["trace[432452686] 'agreement among raft nodes before linearized reading' (duration: 428.998123ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:19:40.304466Z","caller":"traceutil/trace.go:171","msg":"trace[1862230409] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:589; }","duration":"185.928919ms","start":"2026-04-28T07:19:40.118513Z","end":"2026-04-28T07:19:40.304442Z","steps":["trace[1862230409] 'agreement among raft nodes before linearized reading' (duration: 185.806976ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:19:40.304479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:19:39.875244Z","time spent":"429.229259ms","remote":"127.0.0.1:45424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-vrsdk\" "} {"level":"warn","ts":"2026-04-28T07:19:40.304621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:19:39.809742Z","time spent":"494.25934ms","remote":"127.0.0.1:45472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T07:19:45.480839Z","caller":"traceutil/trace.go:171","msg":"trace[599729881] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"102.777049ms","start":"2026-04-28T07:19:45.378035Z","end":"2026-04-28T07:19:45.480812Z","steps":["trace[599729881] 'process raft request' (duration: 102.529243ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:19:55.117213Z","caller":"traceutil/trace.go:171","msg":"trace[777168758] transaction","detail":"{read_only:false; response_revision:744; number_of_response:1; }","duration":"145.068028ms","start":"2026-04-28T07:19:54.972121Z","end":"2026-04-28T07:19:55.117189Z","steps":["trace[777168758] 'process raft request' (duration: 144.903405ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:20:23.90953Z","caller":"traceutil/trace.go:171","msg":"trace[1582526387] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"108.782075ms","start":"2026-04-28T07:20:23.80072Z","end":"2026-04-28T07:20:23.909502Z","steps":["trace[1582526387] 'read index received' (duration: 108.494358ms)","trace[1582526387] 'applied index is now lower than readState.Index' (duration: 286.567µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:20:23.909932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.146393ms","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-28T07:20:23.909997Z","caller":"traceutil/trace.go:171","msg":"trace[1855861683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1147; }","duration":"109.300227ms","start":"2026-04-28T07:20:23.800679Z","end":"2026-04-28T07:20:23.909979Z","steps":["trace[1855861683] 'agreement among raft nodes before linearized reading' (duration: 108.955859ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:20:23.910019Z","caller":"traceutil/trace.go:171","msg":"trace[976800181] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"177.390574ms","start":"2026-04-28T07:20:23.732584Z","end":"2026-04-28T07:20:23.909975Z","steps":["trace[976800181] 'process raft request' (duration: 176.722229ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:20:43.471234Z","caller":"traceutil/trace.go:171","msg":"trace[1797370183] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"101.949745ms","start":"2026-04-28T07:20:43.369251Z","end":"2026-04-28T07:20:43.471201Z","steps":["trace[1797370183] 'process raft request' (duration: 84.215074ms)","trace[1797370183] 'compare' (duration: 17.564017ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:20:43.789778Z","caller":"traceutil/trace.go:171","msg":"trace[1708671941] linearizableReadLoop","detail":"{readStateIndex:1428; appliedIndex:1425; }","duration":"102.63877ms","start":"2026-04-28T07:20:43.68712Z","end":"2026-04-28T07:20:43.789759Z","steps":["trace[1708671941] 'read index received' (duration: 51.263013ms)","trace[1708671941] 'applied index is now lower than readState.Index' (duration: 51.375157ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:20:43.789919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.784663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/ingress-nginx/ingress-nginx-admission-patch-thjn9\" ","response":"range_response_count:1 size:3261"} {"level":"info","ts":"2026-04-28T07:20:43.78995Z","caller":"traceutil/trace.go:171","msg":"trace[1034898245] range","detail":"{range_begin:/registry/pods/ingress-nginx/ingress-nginx-admission-patch-thjn9; range_end:; response_count:1; response_revision:1386; }","duration":"102.850945ms","start":"2026-04-28T07:20:43.687087Z","end":"2026-04-28T07:20:43.789938Z","steps":["trace[1034898245] 'agreement among raft nodes before linearized reading' (duration: 102.743632ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:20:43.789976Z","caller":"traceutil/trace.go:171","msg":"trace[1314148715] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"112.377991ms","start":"2026-04-28T07:20:43.677578Z","end":"2026-04-28T07:20:43.789956Z","steps":["trace[1314148715] 'process raft request' (duration: 60.80981ms)","trace[1314148715] 'compare' (duration: 51.123751ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:20:43.790029Z","caller":"traceutil/trace.go:171","msg":"trace[705132555] transaction","detail":"{read_only:false; response_revision:1385; number_of_response:1; }","duration":"110.332052ms","start":"2026-04-28T07:20:43.679673Z","end":"2026-04-28T07:20:43.790005Z","steps":["trace[705132555] 'process raft request' (duration: 109.980464ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:20:43.790047Z","caller":"traceutil/trace.go:171","msg":"trace[356739169] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"103.905781ms","start":"2026-04-28T07:20:43.686114Z","end":"2026-04-28T07:20:43.79002Z","steps":["trace[356739169] 'process raft request' (duration: 103.593903ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:21:10.66742Z","caller":"traceutil/trace.go:171","msg":"trace[979317425] transaction","detail":"{read_only:false; response_revision:1812; number_of_response:1; }","duration":"157.003532ms","start":"2026-04-28T07:21:10.510383Z","end":"2026-04-28T07:21:10.667386Z","steps":["trace[979317425] 'process raft request' (duration: 156.858359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:21:11.492455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.947206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3c36a094-80aa-4087-a4df-28c2db6602a9\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-28T07:21:11.492556Z","caller":"traceutil/trace.go:171","msg":"trace[656882754] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3c36a094-80aa-4087-a4df-28c2db6602a9; range_end:; response_count:1; response_revision:1816; }","duration":"153.094989ms","start":"2026-04-28T07:21:11.339435Z","end":"2026-04-28T07:21:11.49253Z","steps":["trace[656882754] 'range keys from in-memory index tree' (duration: 152.68505ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:21:11.660873Z","caller":"traceutil/trace.go:171","msg":"trace[1476703144] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"155.790674ms","start":"2026-04-28T07:21:11.505038Z","end":"2026-04-28T07:21:11.660829Z","steps":["trace[1476703144] 'process raft request' (duration: 109.406469ms)","trace[1476703144] 'compare' (duration: 46.136699ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:23:28.047475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.307492ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:23:28.047763Z","caller":"traceutil/trace.go:171","msg":"trace[1860138587] transaction","detail":"{read_only:false; response_revision:2710; number_of_response:1; }","duration":"192.626801ms","start":"2026-04-28T07:23:27.855111Z","end":"2026-04-28T07:23:28.047738Z","steps":["trace[1860138587] 'process raft request' (duration: 192.549219ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:23:28.048269Z","caller":"traceutil/trace.go:171","msg":"trace[560344072] transaction","detail":"{read_only:false; response_revision:2709; number_of_response:1; }","duration":"193.582304ms","start":"2026-04-28T07:23:27.854666Z","end":"2026-04-28T07:23:28.048248Z","steps":["trace[560344072] 'process raft request' (duration: 88.923249ms)","trace[560344072] 'compare' (duration: 103.118478ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:27:23.995381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.637175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-28T07:27:23.995616Z","caller":"traceutil/trace.go:171","msg":"trace[1928808145] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4712; }","duration":"129.000752ms","start":"2026-04-28T07:27:23.866548Z","end":"2026-04-28T07:27:23.995549Z","steps":["trace[1928808145] 'range keys from in-memory index tree' (duration: 128.348949ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:24.375066Z","caller":"traceutil/trace.go:171","msg":"trace[2081880439] linearizableReadLoop","detail":"{readStateIndex:4894; appliedIndex:4893; }","duration":"106.011397ms","start":"2026-04-28T07:27:24.269028Z","end":"2026-04-28T07:27:24.37504Z","steps":["trace[2081880439] 'read index received' (duration: 105.799452ms)","trace[2081880439] 'applied index is now lower than readState.Index' (duration: 210.935µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:27:24.375398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.351903ms","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-28T07:27:24.375446Z","caller":"traceutil/trace.go:171","msg":"trace[2096940840] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4715; }","duration":"106.452045ms","start":"2026-04-28T07:27:24.26898Z","end":"2026-04-28T07:27:24.375432Z","steps":["trace[2096940840] 'agreement among raft nodes before linearized reading' (duration: 106.18986ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:24.375425Z","caller":"traceutil/trace.go:171","msg":"trace[1667114127] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"107.347192ms","start":"2026-04-28T07:27:24.267892Z","end":"2026-04-28T07:27:24.375239Z","steps":["trace[1667114127] 'process raft request' (duration: 107.000996ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:27:24.375578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.331614ms","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-28T07:27:24.375659Z","caller":"traceutil/trace.go:171","msg":"trace[765812804] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4715; }","duration":"102.473537ms","start":"2026-04-28T07:27:24.273164Z","end":"2026-04-28T07:27:24.375638Z","steps":["trace[765812804] 'agreement among raft nodes before linearized reading' (duration: 102.300284ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:24.520847Z","caller":"traceutil/trace.go:171","msg":"trace[786855322] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"142.63081ms","start":"2026-04-28T07:27:24.378182Z","end":"2026-04-28T07:27:24.520813Z","steps":["trace[786855322] 'process raft request' (duration: 76.189455ms)","trace[786855322] 'compare' (duration: 66.275682ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:27:24.533318Z","caller":"traceutil/trace.go:171","msg":"trace[172666137] transaction","detail":"{read_only:false; response_revision:4718; number_of_response:1; }","duration":"150.563445ms","start":"2026-04-28T07:27:24.38274Z","end":"2026-04-28T07:27:24.533304Z","steps":["trace[172666137] 'process raft request' (duration: 150.476063ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:24.533323Z","caller":"traceutil/trace.go:171","msg":"trace[1239174802] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"152.446591ms","start":"2026-04-28T07:27:24.380851Z","end":"2026-04-28T07:27:24.533297Z","steps":["trace[1239174802] 'process raft request' (duration: 152.220857ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:27:24.533584Z","caller":"traceutil/trace.go:171","msg":"trace[330672527] transaction","detail":"{read_only:false; response_revision:4719; number_of_response:1; }","duration":"149.413173ms","start":"2026-04-28T07:27:24.384126Z","end":"2026-04-28T07:27:24.533539Z","steps":["trace[330672527] 'process raft request' (duration: 149.128348ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:28:57.938066Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2866} {"level":"info","ts":"2026-04-28T07:28:58.014479Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2866,"took":"74.590026ms","hash":1701286146,"current-db-size-bytes":53698560,"current-db-size":"54 MB","current-db-size-in-use-bytes":29044736,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-28T07:28:58.014561Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1701286146,"revision":2866,"compact-revision":-1} {"level":"warn","ts":"2026-04-28T07:30:01.514991Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486509653,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:02.015805Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486509653,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:02.320419Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.306736796s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-28T07:30:03.11777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000629701s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-28T07:30:03.117851Z","caller":"traceutil/trace.go:171","msg":"trace[630817403] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000767605s","start":"2026-04-28T07:30:01.117064Z","end":"2026-04-28T07:30:03.117832Z","steps":["trace[630817403] 'agreement among raft nodes before linearized reading' (duration: 2.000660402s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:03.117916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.117043Z","time spent":"2.000847916s","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/28 07:30:03 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-28T07:30:05.118467Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000134581s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-28T07:30:05.118557Z","caller":"traceutil/trace.go:171","msg":"trace[2083380440] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000297515s","start":"2026-04-28T07:30:03.118237Z","end":"2026-04-28T07:30:05.118535Z","steps":["trace[2083380440] 'agreement among raft nodes before linearized reading' (duration: 2.000164642s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:05.118609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:03.118219Z","time spent":"2.000380996s","remote":"127.0.0.1:45238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T07:30:06.049351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999757385s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-28T07:30:06.049522Z","caller":"traceutil/trace.go:171","msg":"trace[502631121] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.99999284s","start":"2026-04-28T07:30:04.049507Z","end":"2026-04-28T07:30:06.0495Z","steps":["trace[502631121] 'agreement among raft nodes before linearized reading' (duration: 1.999794736s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.049902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:04.049485Z","time spent":"2.000398078s","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/04/28 07:30:06 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-28T07:30:06.278762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999923293s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-28T07:30:06.278853Z","caller":"traceutil/trace.go:171","msg":"trace[1135921344] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"5.000077977s","start":"2026-04-28T07:30:01.278753Z","end":"2026-04-28T07:30:06.278831Z","steps":["trace[1135921344] 'agreement among raft nodes before linearized reading' (duration: 4.999956774s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.279282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.278732Z","time spent":"5.000530707s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-28T07:30:06.427343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999298005s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-04-28T07:30:06.427439Z","caller":"traceutil/trace.go:171","msg":"trace[782459483] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999446889s","start":"2026-04-28T07:30:01.427968Z","end":"2026-04-28T07:30:06.427415Z","steps":["trace[782459483] 'agreement among raft nodes before linearized reading' (duration: 4.999325636s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.427681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.427952Z","time spent":"4.999713415s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/04/28 07:30:06 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-04-28T07:30:06.428593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999234945s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-04-28T07:30:06.42869Z","caller":"traceutil/trace.go:171","msg":"trace[1181189719] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999406159s","start":"2026-04-28T07:30:01.429262Z","end":"2026-04-28T07:30:06.428668Z","steps":["trace[1181189719] 'agreement among raft nodes before linearized reading' (duration: 4.999269636s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.428782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.429238Z","time spent":"4.999530472s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T07:30:06.790945Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.47015683s","expected-duration":"1s"} {"level":"warn","ts":"2026-04-28T07:30:06.793942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"817.696809ms","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-28T07:30:06.794083Z","caller":"traceutil/trace.go:171","msg":"trace[1468660584] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:5899; }","duration":"817.854243ms","start":"2026-04-28T07:30:05.976209Z","end":"2026-04-28T07:30:06.794063Z","steps":["trace[1468660584] 'range keys from in-memory index tree' (duration: 817.676569ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.794368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.473605715s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-28T07:30:06.794574Z","caller":"traceutil/trace.go:171","msg":"trace[1534683594] transaction","detail":"{read_only:false; response_revision:5900; number_of_response:1; }","duration":"5.780951536s","start":"2026-04-28T07:30:01.013576Z","end":"2026-04-28T07:30:06.794528Z","steps":["trace[1534683594] 'process raft request' (duration: 1.307117355s)","trace[1534683594] 'compare' (duration: 4.472750946s)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:30:06.794737Z","caller":"traceutil/trace.go:171","msg":"trace[989608439] transaction","detail":"{read_only:false; response_revision:5902; number_of_response:1; }","duration":"4.711784207s","start":"2026-04-28T07:30:02.08293Z","end":"2026-04-28T07:30:06.794715Z","steps":["trace[989608439] 'process raft request' (duration: 4.711586382s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.794786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.013561Z","time spent":"5.78111556s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:30:06.794879Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.082898Z","time spent":"4.71190413s","remote":"127.0.0.1:45502","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-28T07:30:06.794997Z","caller":"traceutil/trace.go:171","msg":"trace[664608042] transaction","detail":"{read_only:false; response_revision:5904; number_of_response:1; }","duration":"3.759767208s","start":"2026-04-28T07:30:03.035222Z","end":"2026-04-28T07:30:06.794989Z","steps":["trace[664608042] 'process raft request' (duration: 3.75940391s)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:06.794996Z","caller":"traceutil/trace.go:171","msg":"trace[2072206620] transaction","detail":"{read_only:false; response_revision:5901; number_of_response:1; }","duration":"5.272176852s","start":"2026-04-28T07:30:01.522797Z","end":"2026-04-28T07:30:06.794973Z","steps":["trace[2072206620] 'process raft request' (duration: 5.27163179s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.795041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:03.035197Z","time spent":"3.759823199s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:30:06.795077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.522769Z","time spent":"5.272268085s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:30:06.795103Z","caller":"traceutil/trace.go:171","msg":"trace[7145811] linearizableReadLoop","detail":"{readStateIndex:6118; appliedIndex:6116; }","duration":"5.780546128s","start":"2026-04-28T07:30:01.014545Z","end":"2026-04-28T07:30:06.795091Z","steps":["trace[7145811] 'read index received' (duration: 1.306167415s)","trace[7145811] 'applied index is now lower than readState.Index' (duration: 4.474377803s)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:30:06.795154Z","caller":"traceutil/trace.go:171","msg":"trace[1933600815] transaction","detail":"{read_only:false; response_revision:5903; number_of_response:1; }","duration":"3.898466766s","start":"2026-04-28T07:30:02.89668Z","end":"2026-04-28T07:30:06.795146Z","steps":["trace[1933600815] 'process raft request' (duration: 3.897912224s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.795195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.896643Z","time spent":"3.898532228s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:30:06.795318Z","caller":"traceutil/trace.go:171","msg":"trace[1033060204] transaction","detail":"{read_only:false; response_revision:5905; number_of_response:1; }","duration":"1.463765647s","start":"2026-04-28T07:30:05.331546Z","end":"2026-04-28T07:30:06.795311Z","steps":["trace[1033060204] 'process raft request' (duration: 1.463181344s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.795321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:05.124711Z","time spent":"1.670605561s","remote":"127.0.0.1:45308","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-04-28T07:30:06.79536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:05.33152Z","time spent":"1.463820798s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:30:06.796505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.765126092s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-04-28T07:30:06.796553Z","caller":"traceutil/trace.go:171","msg":"trace[1655646217] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:5905; }","duration":"5.765212484s","start":"2026-04-28T07:30:01.031328Z","end":"2026-04-28T07:30:06.79654Z","steps":["trace[1655646217] 'agreement among raft nodes before linearized reading' (duration: 5.765061241s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.796584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.030829Z","time spent":"5.765747645s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-04-28T07:30:06.799003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.012864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-28T07:30:06.799032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.809154983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-28T07:30:06.79907Z","caller":"traceutil/trace.go:171","msg":"trace[1265966633] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5905; }","duration":"609.125526ms","start":"2026-04-28T07:30:06.189929Z","end":"2026-04-28T07:30:06.799054Z","steps":["trace[1265966633] 'agreement among raft nodes before linearized reading' (duration: 608.996503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.79911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:06.189906Z","time spent":"609.196638ms","remote":"127.0.0.1:55778","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-04-28T07:30:06.799532Z","caller":"traceutil/trace.go:171","msg":"trace[1417687383] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5905; }","duration":"2.809253975s","start":"2026-04-28T07:30:03.989807Z","end":"2026-04-28T07:30:06.799061Z","steps":["trace[1417687383] 'agreement among raft nodes before linearized reading' (duration: 2.809082241s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.799696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:03.989781Z","time spent":"2.809788576s","remote":"127.0.0.1:45424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-28T07:30:06.799993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.669108546s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:30:06.800035Z","caller":"traceutil/trace.go:171","msg":"trace[723513143] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5905; }","duration":"1.669194298s","start":"2026-04-28T07:30:05.130832Z","end":"2026-04-28T07:30:06.800027Z","steps":["trace[723513143] 'agreement among raft nodes before linearized reading' (duration: 1.669121427s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.800093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:05.130811Z","time spent":"1.669274431s","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T07:30:06.800404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.987434727s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:30:06.800438Z","caller":"traceutil/trace.go:171","msg":"trace[172648044] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5905; }","duration":"1.987502789s","start":"2026-04-28T07:30:04.812925Z","end":"2026-04-28T07:30:06.800428Z","steps":["trace[172648044] 'agreement among raft nodes before linearized reading' (duration: 1.987450528s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.800644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:04.812902Z","time spent":"1.987729323s","remote":"127.0.0.1:45466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":29,"request content":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:06.801655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.054142079s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:30:06.801706Z","caller":"traceutil/trace.go:171","msg":"trace[694006365] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:5905; }","duration":"2.054246791s","start":"2026-04-28T07:30:04.747451Z","end":"2026-04-28T07:30:06.801698Z","steps":["trace[694006365] 'agreement among raft nodes before linearized reading' (duration: 2.054079737s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.801921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:04.747429Z","time spent":"2.054477576s","remote":"127.0.0.1:55646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:06.80242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.787869176s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-28T07:30:06.802444Z","caller":"traceutil/trace.go:171","msg":"trace[1360182918] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:5905; }","duration":"5.787903707s","start":"2026-04-28T07:30:01.014534Z","end":"2026-04-28T07:30:06.802438Z","steps":["trace[1360182918] 'agreement among raft nodes before linearized reading' (duration: 5.780708941s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.802458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.014529Z","time spent":"5.787925437s","remote":"127.0.0.1:45510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"warn","ts":"2026-04-28T07:30:06.803701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.432570303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-28T07:30:06.803714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.919575695s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:06.803746Z","caller":"traceutil/trace.go:171","msg":"trace[1825659102] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5905; }","duration":"4.432656406s","start":"2026-04-28T07:30:02.371079Z","end":"2026-04-28T07:30:06.803736Z","steps":["trace[1825659102] 'agreement among raft nodes before linearized reading' (duration: 4.432574034s)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:06.803753Z","caller":"traceutil/trace.go:171","msg":"trace[1305164195] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:5905; }","duration":"3.919658067s","start":"2026-04-28T07:30:02.884084Z","end":"2026-04-28T07:30:06.803742Z","steps":["trace[1305164195] 'agreement among raft nodes before linearized reading' (duration: 3.919580135s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.803774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.371058Z","time spent":"4.432710486s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T07:30:06.80378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.884063Z","time spent":"3.919709548s","remote":"127.0.0.1:45732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":18,"response size":31,"request content":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:06.803886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.128014329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:06.803914Z","caller":"traceutil/trace.go:171","msg":"trace[530733535] range","detail":"{range_begin:/registry/monitoring.coreos.com/podmonitors/; range_end:/registry/monitoring.coreos.com/podmonitors0; response_count:0; response_revision:5905; }","duration":"4.12808406s","start":"2026-04-28T07:30:02.675822Z","end":"2026-04-28T07:30:06.803906Z","steps":["trace[530733535] 'agreement among raft nodes before linearized reading' (duration: 4.128019799s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.803969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.948843113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:06.804005Z","caller":"traceutil/trace.go:171","msg":"trace[1615562163] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5905; }","duration":"2.948935885s","start":"2026-04-28T07:30:03.855058Z","end":"2026-04-28T07:30:06.803994Z","steps":["trace[1615562163] 'agreement among raft nodes before linearized reading' (duration: 2.948864934s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.803993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.675802Z","time spent":"4.128182693s","remote":"127.0.0.1:34796","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":6,"response size":31,"request content":"key:\"/registry/monitoring.coreos.com/podmonitors/\" range_end:\"/registry/monitoring.coreos.com/podmonitors0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:06.804052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:03.855038Z","time spent":"2.948984796s","remote":"127.0.0.1:55798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:06.804116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.535816839s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-04-28T07:30:06.804143Z","caller":"traceutil/trace.go:171","msg":"trace[1559051732] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:5905; }","duration":"4.53588187s","start":"2026-04-28T07:30:02.268253Z","end":"2026-04-28T07:30:06.804135Z","steps":["trace[1559051732] 'agreement among raft nodes before linearized reading' (duration: 4.535749298s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.804163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.268231Z","time spent":"4.535927541s","remote":"127.0.0.1:45410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":699,"request content":"key:\"/registry/services/endpoints/openstack/keystone-api\" "} {"level":"warn","ts":"2026-04-28T07:30:06.804269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.434638898s","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-28T07:30:06.804289Z","caller":"traceutil/trace.go:171","msg":"trace[1484650378] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5905; }","duration":"4.43468946s","start":"2026-04-28T07:30:02.369594Z","end":"2026-04-28T07:30:06.804283Z","steps":["trace[1484650378] 'agreement among raft nodes before linearized reading' (duration: 4.434653279s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.804306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.369575Z","time spent":"4.43472781s","remote":"127.0.0.1:45502","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-28T07:30:06.804443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.725348402s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:529"} {"level":"info","ts":"2026-04-28T07:30:06.804466Z","caller":"traceutil/trace.go:171","msg":"trace[1633677001] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:5905; }","duration":"4.725404713s","start":"2026-04-28T07:30:02.079055Z","end":"2026-04-28T07:30:06.80446Z","steps":["trace[1633677001] 'agreement among raft nodes before linearized reading' (duration: 4.72526406s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.804479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.373459556s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:06.804912Z","caller":"traceutil/trace.go:171","msg":"trace[380143420] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:5905; }","duration":"5.373952056s","start":"2026-04-28T07:30:01.43095Z","end":"2026-04-28T07:30:06.804902Z","steps":["trace[380143420] 'agreement among raft nodes before linearized reading' (duration: 5.373474346s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:06.804952Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:01.43094Z","time spent":"5.374000547s","remote":"127.0.0.1:45394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":4,"response size":31,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:06.806812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:02.079037Z","time spent":"4.725441444s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":553,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"info","ts":"2026-04-28T07:30:10.913713Z","caller":"traceutil/trace.go:171","msg":"trace[1492298233] transaction","detail":"{read_only:false; response_revision:5931; number_of_response:1; }","duration":"102.116027ms","start":"2026-04-28T07:30:10.811569Z","end":"2026-04-28T07:30:10.913685Z","steps":["trace[1492298233] 'process raft request' (duration: 101.925143ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:10.919964Z","caller":"traceutil/trace.go:171","msg":"trace[2059861747] transaction","detail":"{read_only:false; response_revision:5932; number_of_response:1; }","duration":"105.804318ms","start":"2026-04-28T07:30:10.814071Z","end":"2026-04-28T07:30:10.919876Z","steps":["trace[2059861747] 'process raft request' (duration: 105.525122ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:10.920067Z","caller":"traceutil/trace.go:171","msg":"trace[2867049] linearizableReadLoop","detail":"{readStateIndex:6152; appliedIndex:6149; }","duration":"103.938237ms","start":"2026-04-28T07:30:10.816108Z","end":"2026-04-28T07:30:10.920046Z","steps":["trace[2867049] 'read index received' (duration: 97.378364ms)","trace[2867049] 'applied index is now lower than readState.Index' (duration: 6.557703ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:30:10.920398Z","caller":"traceutil/trace.go:171","msg":"trace[1915939932] transaction","detail":"{read_only:false; response_revision:5933; number_of_response:1; }","duration":"106.208596ms","start":"2026-04-28T07:30:10.814131Z","end":"2026-04-28T07:30:10.920339Z","steps":["trace[1915939932] 'process raft request' (duration: 105.685545ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:10.92048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.360076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-28T07:30:10.920511Z","caller":"traceutil/trace.go:171","msg":"trace[1488152209] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5933; }","duration":"104.411087ms","start":"2026-04-28T07:30:10.81609Z","end":"2026-04-28T07:30:10.920501Z","steps":["trace[1488152209] 'agreement among raft nodes before linearized reading' (duration: 104.031629ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:12.791645Z","caller":"traceutil/trace.go:171","msg":"trace[1277453520] transaction","detail":"{read_only:false; response_revision:5945; number_of_response:1; }","duration":"136.965958ms","start":"2026-04-28T07:30:12.654656Z","end":"2026-04-28T07:30:12.791622Z","steps":["trace[1277453520] 'process raft request' (duration: 136.817005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:29.131581Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486509970,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:29.631922Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486509970,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:30.284887Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486509970,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:30.317076Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.889578802s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T07:30:30.31755Z","caller":"traceutil/trace.go:171","msg":"trace[1381886510] transaction","detail":"{read_only:false; response_revision:6028; number_of_response:1; }","duration":"1.890175875s","start":"2026-04-28T07:30:28.427344Z","end":"2026-04-28T07:30:30.31752Z","steps":["trace[1381886510] 'process raft request' (duration: 1.88994307s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.317764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:28.427313Z","time spent":"1.890341519s","remote":"127.0.0.1:45502","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-28T07:30:30.318551Z","caller":"traceutil/trace.go:171","msg":"trace[1077555352] transaction","detail":"{read_only:false; response_revision:6029; number_of_response:1; }","duration":"854.295335ms","start":"2026-04-28T07:30:29.464235Z","end":"2026-04-28T07:30:30.31853Z","steps":["trace[1077555352] 'process raft request' (duration: 854.08933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.318732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.464221Z","time spent":"854.447808ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:30:30.319032Z","caller":"traceutil/trace.go:171","msg":"trace[1938132833] linearizableReadLoop","detail":"{readStateIndex:6254; appliedIndex:6250; }","duration":"1.762101858s","start":"2026-04-28T07:30:28.556904Z","end":"2026-04-28T07:30:30.319006Z","steps":["trace[1938132833] 'read index received' (duration: 1.760576904s)","trace[1938132833] 'applied index is now lower than readState.Index' (duration: 1.523544ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:30:30.319216Z","caller":"traceutil/trace.go:171","msg":"trace[276868071] transaction","detail":"{read_only:false; response_revision:6030; number_of_response:1; }","duration":"852.603707ms","start":"2026-04-28T07:30:29.466593Z","end":"2026-04-28T07:30:30.319197Z","steps":["trace[276868071] 'process raft request' (duration: 851.866561ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:30.319256Z","caller":"traceutil/trace.go:171","msg":"trace[1801599647] transaction","detail":"{read_only:false; response_revision:6031; number_of_response:1; }","duration":"581.779269ms","start":"2026-04-28T07:30:29.737463Z","end":"2026-04-28T07:30:30.319242Z","steps":["trace[1801599647] 'process raft request' (duration: 581.38328ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.319319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.466521Z","time spent":"852.74691ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:30:30.319517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.760119914s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keystone-domain-manage-5phsl\" ","response":"range_response_count:1 size:8277"} {"level":"info","ts":"2026-04-28T07:30:30.319588Z","caller":"traceutil/trace.go:171","msg":"trace[1141430296] range","detail":"{range_begin:/registry/pods/openstack/keystone-domain-manage-5phsl; range_end:; response_count:1; response_revision:6031; }","duration":"1.760223996s","start":"2026-04-28T07:30:28.559342Z","end":"2026-04-28T07:30:30.319566Z","steps":["trace[1141430296] 'agreement among raft nodes before linearized reading' (duration: 1.759996411s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.319641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:28.559332Z","time spent":"1.760299117s","remote":"127.0.0.1:45424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":8301,"request content":"key:\"/registry/pods/openstack/keystone-domain-manage-5phsl\" "} {"level":"warn","ts":"2026-04-28T07:30:30.319807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.47587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-28T07:30:30.319864Z","caller":"traceutil/trace.go:171","msg":"trace[484852097] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:6031; }","duration":"855.544421ms","start":"2026-04-28T07:30:29.464307Z","end":"2026-04-28T07:30:30.319851Z","steps":["trace[484852097] 'agreement among raft nodes before linearized reading' (duration: 855.288676ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.319899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.464302Z","time spent":"855.591142ms","remote":"127.0.0.1:45394","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1889,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-04-28T07:30:30.320065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"855.798267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T07:30:30.320107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.763202131s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-28T07:30:30.320129Z","caller":"traceutil/trace.go:171","msg":"trace[1471725053] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:6031; }","duration":"855.881999ms","start":"2026-04-28T07:30:29.46423Z","end":"2026-04-28T07:30:30.320112Z","steps":["trace[1471725053] 'agreement among raft nodes before linearized reading' (duration: 855.779567ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.320174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.464225Z","time spent":"855.93917ms","remote":"127.0.0.1:49272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:30.320333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.737439Z","time spent":"581.85463ms","remote":"127.0.0.1:45502","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-28T07:30:30.320393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.029433ms","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-28T07:30:30.320426Z","caller":"traceutil/trace.go:171","msg":"trace[209834902] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6031; }","duration":"856.077223ms","start":"2026-04-28T07:30:29.464341Z","end":"2026-04-28T07:30:30.320419Z","steps":["trace[209834902] 'agreement among raft nodes before linearized reading' (duration: 856.013141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.320448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.464334Z","time spent":"856.107875ms","remote":"127.0.0.1:45502","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-28T07:30:30.320445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.373441ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:30.320496Z","caller":"traceutil/trace.go:171","msg":"trace[1736184065] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:6031; }","duration":"856.425422ms","start":"2026-04-28T07:30:29.464059Z","end":"2026-04-28T07:30:30.320484Z","steps":["trace[1736184065] 'agreement among raft nodes before linearized reading' (duration: 856.297228ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.320535Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.46401Z","time spent":"856.516264ms","remote":"127.0.0.1:49356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":35,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:30.320635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.282578ms","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-28T07:30:30.320674Z","caller":"traceutil/trace.go:171","msg":"trace[733412117] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6031; }","duration":"856.32956ms","start":"2026-04-28T07:30:29.464335Z","end":"2026-04-28T07:30:30.320665Z","steps":["trace[733412117] 'agreement among raft nodes before linearized reading' (duration: 856.264908ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.320705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.464332Z","time spent":"856.3624ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-28T07:30:30.320727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.658267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:30.32076Z","caller":"traceutil/trace.go:171","msg":"trace[661757070] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:6031; }","duration":"856.723887ms","start":"2026-04-28T07:30:29.464027Z","end":"2026-04-28T07:30:30.320751Z","steps":["trace[661757070] 'agreement among raft nodes before linearized reading' (duration: 856.665746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.320801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.464011Z","time spent":"856.780899ms","remote":"127.0.0.1:45620","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:30.320853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"856.518473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-28T07:30:30.320885Z","caller":"traceutil/trace.go:171","msg":"trace[2107218800] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6031; }","duration":"856.572154ms","start":"2026-04-28T07:30:29.464304Z","end":"2026-04-28T07:30:30.320876Z","steps":["trace[2107218800] 'agreement among raft nodes before linearized reading' (duration: 856.507523ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.32091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:29.464296Z","time spent":"856.608125ms","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-28T07:30:30.320993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.705927477s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:30.321038Z","caller":"traceutil/trace.go:171","msg":"trace[1633743744] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:6031; }","duration":"1.706022278s","start":"2026-04-28T07:30:28.615004Z","end":"2026-04-28T07:30:30.321026Z","steps":["trace[1633743744] 'agreement among raft nodes before linearized reading' (duration: 1.705948537s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.321069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:28.614978Z","time spent":"1.7060829s","remote":"127.0.0.1:51876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":31,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"info","ts":"2026-04-28T07:30:30.320141Z","caller":"traceutil/trace.go:171","msg":"trace[417976953] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6031; }","duration":"1.763282823s","start":"2026-04-28T07:30:28.55685Z","end":"2026-04-28T07:30:30.320132Z","steps":["trace[417976953] 'agreement among raft nodes before linearized reading' (duration: 1.763192201s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.321185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:28.556825Z","time spent":"1.764351247s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-04-28T07:30:30.321285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.73756777s","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-28T07:30:30.32131Z","caller":"traceutil/trace.go:171","msg":"trace[1636501885] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6031; }","duration":"1.73762866s","start":"2026-04-28T07:30:28.583674Z","end":"2026-04-28T07:30:30.321302Z","steps":["trace[1636501885] 'agreement among raft nodes before linearized reading' (duration: 1.737564489s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:30.321327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:28.583653Z","time spent":"1.737669912s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-04-28T07:30:41.462623Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486510159,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:41.963438Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486510159,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:42.330138Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.756526592s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T07:30:42.330516Z","caller":"traceutil/trace.go:171","msg":"trace[731267275] linearizableReadLoop","detail":"{readStateIndex:6340; appliedIndex:6339; }","duration":"1.368212234s","start":"2026-04-28T07:30:40.962281Z","end":"2026-04-28T07:30:42.330494Z","steps":["trace[731267275] 'read index received' (duration: 1.36800271s)","trace[731267275] 'applied index is now lower than readState.Index' (duration: 208.734µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:30:42.330739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.368440599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.196\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-28T07:30:42.330788Z","caller":"traceutil/trace.go:171","msg":"trace[1721094335] range","detail":"{range_begin:/registry/masterleases/199.19.213.196; range_end:; response_count:1; response_revision:6115; }","duration":"1.368550892s","start":"2026-04-28T07:30:40.962223Z","end":"2026-04-28T07:30:42.330774Z","steps":["trace[1721094335] 'agreement among raft nodes before linearized reading' (duration: 1.368382708s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:42.330798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.239637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:30:42.330888Z","caller":"traceutil/trace.go:171","msg":"trace[936935155] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6115; }","duration":"772.39196ms","start":"2026-04-28T07:30:41.55848Z","end":"2026-04-28T07:30:42.330872Z","steps":["trace[936935155] 'agreement among raft nodes before linearized reading' (duration: 772.227336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:42.330936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:41.558457Z","time spent":"772.469852ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T07:30:42.330828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:40.962196Z","time spent":"1.368621593s","remote":"127.0.0.1:45274","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.196\" "} {"level":"warn","ts":"2026-04-28T07:30:42.330786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.319193296s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:42.331035Z","caller":"traceutil/trace.go:171","msg":"trace[417741936] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:6115; }","duration":"1.319509403s","start":"2026-04-28T07:30:41.011506Z","end":"2026-04-28T07:30:42.331015Z","steps":["trace[417741936] 'agreement among raft nodes before linearized reading' (duration: 1.319128504s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:42.331081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:41.011488Z","time spent":"1.319580424s","remote":"127.0.0.1:45702","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":17,"response size":31,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:42.330851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.553502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:30:42.330643Z","caller":"traceutil/trace.go:171","msg":"trace[975493068] transaction","detail":"{read_only:false; response_revision:6115; number_of_response:1; }","duration":"1.757104805s","start":"2026-04-28T07:30:40.573488Z","end":"2026-04-28T07:30:42.330593Z","steps":["trace[975493068] 'process raft request' (duration: 1.756850389s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:42.331371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:40.573467Z","time spent":"1.75777913s","remote":"127.0.0.1:45472","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6923,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:30:42.331322Z","caller":"traceutil/trace.go:171","msg":"trace[1472335809] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6115; }","duration":"216.044793ms","start":"2026-04-28T07:30:42.115159Z","end":"2026-04-28T07:30:42.331204Z","steps":["trace[1472335809] 'agreement among raft nodes before linearized reading' (duration: 215.516321ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:46.060644Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486510213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:46.561103Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486510213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:47.061873Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486510213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:47.562567Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4700242690486510213,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-04-28T07:30:47.990221Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.655028247s","expected-duration":"1s"} {"level":"info","ts":"2026-04-28T07:30:47.990906Z","caller":"traceutil/trace.go:171","msg":"trace[1813498012] transaction","detail":"{read_only:false; response_revision:6142; number_of_response:1; }","duration":"2.655839894s","start":"2026-04-28T07:30:45.335044Z","end":"2026-04-28T07:30:47.990884Z","steps":["trace[1813498012] 'process raft request' (duration: 2.655667381s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:47.991166Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:45.335017Z","time spent":"2.655948537s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T07:30:48.050386Z","caller":"traceutil/trace.go:171","msg":"trace[1182793758] linearizableReadLoop","detail":"{readStateIndex:6372; appliedIndex:6367; }","duration":"2.490500655s","start":"2026-04-28T07:30:45.559856Z","end":"2026-04-28T07:30:48.050357Z","steps":["trace[1182793758] 'read index received' (duration: 2.430908112s)","trace[1182793758] 'applied index is now lower than readState.Index' (duration: 59.590973ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T07:30:48.05069Z","caller":"traceutil/trace.go:171","msg":"trace[946994944] transaction","detail":"{read_only:false; response_revision:6143; number_of_response:1; }","duration":"1.660738586s","start":"2026-04-28T07:30:46.389921Z","end":"2026-04-28T07:30:48.05066Z","steps":["trace[946994944] 'process raft request' (duration: 1.659515788s)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:48.0507Z","caller":"traceutil/trace.go:171","msg":"trace[1847015186] transaction","detail":"{read_only:false; response_revision:6145; number_of_response:1; }","duration":"1.62232364s","start":"2026-04-28T07:30:46.42834Z","end":"2026-04-28T07:30:48.050664Z","steps":["trace[1847015186] 'process raft request' (duration: 1.621969192s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.050839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.38989Z","time spent":"1.660864529s","remote":"127.0.0.1:45502","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-28T07:30:48.050853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.847659443s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:30:48.051034Z","caller":"traceutil/trace.go:171","msg":"trace[282866301] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:6145; }","duration":"1.847872028s","start":"2026-04-28T07:30:46.203105Z","end":"2026-04-28T07:30:48.050977Z","steps":["trace[282866301] 'agreement among raft nodes before linearized reading' (duration: 1.847589941s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.051142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.428314Z","time spent":"1.622532174s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:30:48.051497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.409521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T07:30:48.051457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58325685s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-28T07:30:48.051506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"933.200314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:30:48.051529Z","caller":"traceutil/trace.go:171","msg":"trace[1143823219] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:6145; }","duration":"203.477692ms","start":"2026-04-28T07:30:47.848041Z","end":"2026-04-28T07:30:48.051519Z","steps":["trace[1143823219] 'agreement among raft nodes before linearized reading' (duration: 203.438341ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:48.051563Z","caller":"traceutil/trace.go:171","msg":"trace[140752356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6145; }","duration":"933.287366ms","start":"2026-04-28T07:30:47.118259Z","end":"2026-04-28T07:30:48.051546Z","steps":["trace[140752356] 'agreement among raft nodes before linearized reading' (duration: 933.218624ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:48.051583Z","caller":"traceutil/trace.go:171","msg":"trace[1430708774] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6145; }","duration":"1.583394293s","start":"2026-04-28T07:30:46.468141Z","end":"2026-04-28T07:30:48.051535Z","steps":["trace[1430708774] 'agreement among raft nodes before linearized reading' (duration: 1.583088606s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.051583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.390551276s","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":"warn","ts":"2026-04-28T07:30:48.051624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:47.118241Z","time spent":"933.371538ms","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-28T07:30:48.051649Z","caller":"traceutil/trace.go:171","msg":"trace[52209113] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:6145; }","duration":"1.390674899s","start":"2026-04-28T07:30:46.660954Z","end":"2026-04-28T07:30:48.051629Z","steps":["trace[52209113] 'agreement among raft nodes before linearized reading' (duration: 1.390559716s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.051711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.468114Z","time spent":"1.583515235s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T07:30:48.051827Z","caller":"traceutil/trace.go:171","msg":"trace[2034576408] transaction","detail":"{read_only:false; response_revision:6144; number_of_response:1; }","duration":"1.632543305s","start":"2026-04-28T07:30:46.419274Z","end":"2026-04-28T07:30:48.051817Z","steps":["trace[2034576408] 'process raft request' (duration: 1.630926679s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.051878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.419256Z","time spent":"1.632594437s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T07:30:48.051695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.660927Z","time spent":"1.39075445s","remote":"127.0.0.1:50652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":9,"response size":31,"request content":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true "} {"level":"warn","ts":"2026-04-28T07:30:48.051958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.587877602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-04-28T07:30:48.051261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58279599s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-04-28T07:30:48.051296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.567912222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-04-28T07:30:48.051334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568084576s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-04-28T07:30:48.0514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.573102747s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-28T07:30:48.051441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.491586179s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-04-28T07:30:48.051457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.899361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-28T07:30:48.051158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.203083Z","time spent":"1.8480156s","remote":"127.0.0.1:55816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-04-28T07:30:48.052013Z","caller":"traceutil/trace.go:171","msg":"trace[989543324] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6145; }","duration":"1.587965724s","start":"2026-04-28T07:30:46.464034Z","end":"2026-04-28T07:30:48.051999Z","steps":["trace[989543324] 'agreement among raft nodes before linearized reading' (duration: 1.587826741s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.053661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.46402Z","time spent":"1.58962083s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-28T07:30:48.05378Z","caller":"traceutil/trace.go:171","msg":"trace[1718619654] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6145; }","duration":"2.493198005s","start":"2026-04-28T07:30:45.559805Z","end":"2026-04-28T07:30:48.053003Z","steps":["trace[1718619654] 'agreement among raft nodes before linearized reading' (duration: 2.491533838s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.053848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:45.559788Z","time spent":"2.494041244s","remote":"127.0.0.1:45424","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-28T07:30:48.05348Z","caller":"traceutil/trace.go:171","msg":"trace[1073897933] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6145; }","duration":"1.58419947s","start":"2026-04-28T07:30:46.468399Z","end":"2026-04-28T07:30:48.052599Z","steps":["trace[1073897933] 'agreement among raft nodes before linearized reading' (duration: 1.582736218s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.054179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.46835Z","time spent":"1.585810006s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-04-28T07:30:48.053633Z","caller":"traceutil/trace.go:171","msg":"trace[1647594651] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:6145; }","duration":"1.56968162s","start":"2026-04-28T07:30:46.483209Z","end":"2026-04-28T07:30:48.05289Z","steps":["trace[1647594651] 'agreement among raft nodes before linearized reading' (duration: 1.568076775s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.054454Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.483194Z","time spent":"1.571241456s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":581,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-04-28T07:30:48.053727Z","caller":"traceutil/trace.go:171","msg":"trace[1654856188] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6145; }","duration":"1.574665021s","start":"2026-04-28T07:30:46.478267Z","end":"2026-04-28T07:30:48.052932Z","steps":["trace[1654856188] 'agreement among raft nodes before linearized reading' (duration: 1.573087047s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.05462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.478253Z","time spent":"1.576290767s","remote":"127.0.0.1:45502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-28T07:30:48.054093Z","caller":"traceutil/trace.go:171","msg":"trace[1762927100] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:6145; }","duration":"264.529497ms","start":"2026-04-28T07:30:47.788512Z","end":"2026-04-28T07:30:48.053041Z","steps":["trace[1762927100] 'agreement among raft nodes before linearized reading' (duration: 262.922472ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:30:48.053535Z","caller":"traceutil/trace.go:171","msg":"trace[66618271] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6145; }","duration":"1.569526727s","start":"2026-04-28T07:30:46.48331Z","end":"2026-04-28T07:30:48.052837Z","steps":["trace[66618271] 'agreement among raft nodes before linearized reading' (duration: 1.567791869s)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:30:48.055417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T07:30:46.483288Z","time spent":"1.572111305s","remote":"127.0.0.1:45502","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":"info","ts":"2026-04-28T07:33:57.943931Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5534} {"level":"info","ts":"2026-04-28T07:33:58.017953Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5534,"took":"72.45215ms","hash":97543480,"current-db-size-bytes":53698560,"current-db-size":"54 MB","current-db-size-in-use-bytes":18092032,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-28T07:33:58.018084Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":97543480,"revision":5534,"compact-revision":2866} {"level":"info","ts":"2026-04-28T07:34:11.119893Z","caller":"traceutil/trace.go:171","msg":"trace[566516854] linearizableReadLoop","detail":"{readStateIndex:7683; appliedIndex:7682; }","duration":"137.861303ms","start":"2026-04-28T07:34:10.982008Z","end":"2026-04-28T07:34:11.119869Z","steps":["trace[566516854] 'read index received' (duration: 137.731871ms)","trace[566516854] 'applied index is now lower than readState.Index' (duration: 127.812µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:34:11.120052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.993185ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/envoy-gateway-system/\" range_end:\"/registry/persistentvolumeclaims/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:34:11.120143Z","caller":"traceutil/trace.go:171","msg":"trace[292420157] range","detail":"{range_begin:/registry/persistentvolumeclaims/envoy-gateway-system/; range_end:/registry/persistentvolumeclaims/envoy-gateway-system0; response_count:0; response_revision:7406; }","duration":"138.139967ms","start":"2026-04-28T07:34:10.981982Z","end":"2026-04-28T07:34:11.120122Z","steps":["trace[292420157] 'agreement among raft nodes before linearized reading' (duration: 137.960684ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:11.205216Z","caller":"traceutil/trace.go:171","msg":"trace[1818844574] transaction","detail":"{read_only:false; response_revision:7407; number_of_response:1; }","duration":"163.866826ms","start":"2026-04-28T07:34:11.041332Z","end":"2026-04-28T07:34:11.205199Z","steps":["trace[1818844574] 'process raft request' (duration: 150.529803ms)","trace[1818844574] 'compare' (duration: 12.875004ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:34:11.205396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.365948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T07:34:11.205457Z","caller":"traceutil/trace.go:171","msg":"trace[444535149] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:7409; }","duration":"119.49002ms","start":"2026-04-28T07:34:11.085956Z","end":"2026-04-28T07:34:11.205446Z","steps":["trace[444535149] 'agreement among raft nodes before linearized reading' (duration: 119.361738ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:34:11.205482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.032533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/default\" ","response":"range_response_count:1 size:181"} {"level":"info","ts":"2026-04-28T07:34:11.205509Z","caller":"traceutil/trace.go:171","msg":"trace[729025248] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/default; range_end:; response_count:1; response_revision:7409; }","duration":"151.097763ms","start":"2026-04-28T07:34:11.054403Z","end":"2026-04-28T07:34:11.205501Z","steps":["trace[729025248] 'agreement among raft nodes before linearized reading' (duration: 150.977451ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:11.205506Z","caller":"traceutil/trace.go:171","msg":"trace[691710264] transaction","detail":"{read_only:false; response_revision:7409; number_of_response:1; }","duration":"147.348916ms","start":"2026-04-28T07:34:11.058126Z","end":"2026-04-28T07:34:11.205475Z","steps":["trace[691710264] 'process raft request' (duration: 146.990739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:34:11.205634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.77948ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/\" range_end:\"/registry/rolebindings/envoy-gateway-system0\" limit:500 ","response":"range_response_count:3 size:3302"} {"level":"info","ts":"2026-04-28T07:34:11.205668Z","caller":"traceutil/trace.go:171","msg":"trace[178266790] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/; range_end:/registry/rolebindings/envoy-gateway-system0; response_count:3; response_revision:7409; }","duration":"171.844931ms","start":"2026-04-28T07:34:11.033816Z","end":"2026-04-28T07:34:11.205661Z","steps":["trace[178266790] 'agreement among raft nodes before linearized reading' (duration: 171.76667ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:11.20568Z","caller":"traceutil/trace.go:171","msg":"trace[1401891776] transaction","detail":"{read_only:false; response_revision:7408; number_of_response:1; }","duration":"147.845874ms","start":"2026-04-28T07:34:11.057823Z","end":"2026-04-28T07:34:11.205669Z","steps":["trace[1401891776] 'process raft request' (duration: 147.253483ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:34:11.205954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.672003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/cert-manager/cert-manager-webhook\" ","response":"range_response_count:1 size:971"} {"level":"info","ts":"2026-04-28T07:34:11.206051Z","caller":"traceutil/trace.go:171","msg":"trace[943735389] range","detail":"{range_begin:/registry/serviceaccounts/cert-manager/cert-manager-webhook; range_end:; response_count:1; response_revision:7409; }","duration":"184.813466ms","start":"2026-04-28T07:34:11.021216Z","end":"2026-04-28T07:34:11.206029Z","steps":["trace[943735389] 'agreement among raft nodes before linearized reading' (duration: 184.553321ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:13.351581Z","caller":"traceutil/trace.go:171","msg":"trace[1450153480] transaction","detail":"{read_only:false; response_revision:7418; number_of_response:1; }","duration":"141.445823ms","start":"2026-04-28T07:34:13.210107Z","end":"2026-04-28T07:34:13.351553Z","steps":["trace[1450153480] 'process raft request' (duration: 141.2693ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:13.40051Z","caller":"traceutil/trace.go:171","msg":"trace[1237546838] transaction","detail":"{read_only:false; response_revision:7419; number_of_response:1; }","duration":"189.953475ms","start":"2026-04-28T07:34:13.210541Z","end":"2026-04-28T07:34:13.400494Z","steps":["trace[1237546838] 'process raft request' (duration: 189.816453ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:13.400781Z","caller":"traceutil/trace.go:171","msg":"trace[946029570] linearizableReadLoop","detail":"{readStateIndex:7697; appliedIndex:7694; }","duration":"173.675979ms","start":"2026-04-28T07:34:13.227074Z","end":"2026-04-28T07:34:13.400749Z","steps":["trace[946029570] 'read index received' (duration: 124.382203ms)","trace[946029570] 'applied index is now lower than readState.Index' (duration: 49.292466ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T07:34:13.400909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.599977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-node-lease/\" range_end:\"/registry/rolebindings/kube-node-lease0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T07:34:13.40089Z","caller":"traceutil/trace.go:171","msg":"trace[1899786638] transaction","detail":"{read_only:false; response_revision:7420; number_of_response:1; }","duration":"190.175909ms","start":"2026-04-28T07:34:13.210678Z","end":"2026-04-28T07:34:13.400854Z","steps":["trace[1899786638] 'process raft request' (duration: 189.773062ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:13.400961Z","caller":"traceutil/trace.go:171","msg":"trace[1617405798] range","detail":"{range_begin:/registry/rolebindings/kube-node-lease/; range_end:/registry/rolebindings/kube-node-lease0; response_count:0; response_revision:7421; }","duration":"173.698739ms","start":"2026-04-28T07:34:13.227232Z","end":"2026-04-28T07:34:13.400931Z","steps":["trace[1617405798] 'agreement among raft nodes before linearized reading' (duration: 173.627468ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:34:13.401022Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.925213ms","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-28T07:34:13.401108Z","caller":"traceutil/trace.go:171","msg":"trace[1111173143] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7421; }","duration":"174.043875ms","start":"2026-04-28T07:34:13.227043Z","end":"2026-04-28T07:34:13.401087Z","steps":["trace[1111173143] 'agreement among raft nodes before linearized reading' (duration: 173.797601ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:34:13.401171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.74533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"warn","ts":"2026-04-28T07:34:13.401195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.034131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/envoy-gateway-config\" ","response":"range_response_count:1 size:1550"} {"level":"info","ts":"2026-04-28T07:34:13.401208Z","caller":"traceutil/trace.go:171","msg":"trace[940725243] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:7421; }","duration":"134.826082ms","start":"2026-04-28T07:34:13.266371Z","end":"2026-04-28T07:34:13.401197Z","steps":["trace[940725243] 'agreement among raft nodes before linearized reading' (duration: 134.73847ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T07:34:13.401227Z","caller":"traceutil/trace.go:171","msg":"trace[1644189991] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/envoy-gateway-config; range_end:; response_count:1; response_revision:7421; }","duration":"160.103081ms","start":"2026-04-28T07:34:13.241113Z","end":"2026-04-28T07:34:13.401216Z","steps":["trace[1644189991] 'agreement among raft nodes before linearized reading' (duration: 160.01162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T07:34:13.401298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.245838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-public/\" range_end:\"/registry/configmaps/kube-public0\" limit:500 ","response":"range_response_count:2 size:3917"} {"level":"info","ts":"2026-04-28T07:34:13.401361Z","caller":"traceutil/trace.go:171","msg":"trace[2128621093] range","detail":"{range_begin:/registry/configmaps/kube-public/; range_end:/registry/configmaps/kube-public0; response_count:2; response_revision:7421; }","duration":"147.37949ms","start":"2026-04-28T07:34:13.253963Z","end":"2026-04-28T07:34:13.401343Z","steps":["trace[2128621093] 'agreement among raft nodes before linearized reading' (duration: 147.129225ms)"],"step_count":1}