{"level":"warn","ts":"2026-05-05T09:40:10.777389Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T09:40:10.777537Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.212: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.212:2380","--initial-cluster=instance=https://199.19.213.212:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.212:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.212:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]}
{"level":"warn","ts":"2026-05-05T09:40:10.77764Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."}
{"level":"info","ts":"2026-05-05T09:40:10.777663Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.212:2380"]}
{"level":"info","ts":"2026-05-05T09:40:10.777702Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-05T09:40:10.781014Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"]}
{"level":"info","ts":"2026-05-05T09:40:10.781191Z","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.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.212:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"}
{"level":"info","ts":"2026-05-05T09:40:10.787306Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.747831ms"}
{"level":"info","ts":"2026-05-05T09:40:10.79908Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e1ab0380b9290bdc","cluster-id":"a3ed131e36ad6843"}
{"level":"info","ts":"2026-05-05T09:40:10.799204Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=()"}
{"level":"info","ts":"2026-05-05T09:40:10.799247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 0"}
{"level":"info","ts":"2026-05-05T09:40:10.799273Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e1ab0380b9290bdc [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"}
{"level":"info","ts":"2026-05-05T09:40:10.799288Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became follower at term 1"}
{"level":"info","ts":"2026-05-05T09:40:10.799344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"}
{"level":"warn","ts":"2026-05-05T09:40:10.823143Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"}
{"level":"info","ts":"2026-05-05T09:40:10.829354Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1}
{"level":"info","ts":"2026-05-05T09:40:10.832632Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"}
{"level":"info","ts":"2026-05-05T09:40:10.836908Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e1ab0380b9290bdc","local-server-version":"3.5.12","cluster-version":"to_be_decided"}
{"level":"info","ts":"2026-05-05T09:40:10.842948Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e1ab0380b9290bdc","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"}
{"level":"info","ts":"2026-05-05T09:40:10.843538Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-05T09:40:10.84456Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-05T09:40:10.84463Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"}
{"level":"info","ts":"2026-05-05T09:40:10.844892Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc switched to configuration voters=(16261094730948479964)"}
{"level":"info","ts":"2026-05-05T09:40:10.845049Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","added-peer-id":"e1ab0380b9290bdc","added-peer-peer-urls":["https://199.19.213.212:2380"]}
{"level":"info","ts":"2026-05-05T09:40:10.845942Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]}
{"level":"info","ts":"2026-05-05T09:40:10.846178Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e1ab0380b9290bdc","initial-advertise-peer-urls":["https://199.19.213.212:2380"],"listen-peer-urls":["https://199.19.213.212:2380"],"advertise-client-urls":["https://199.19.213.212:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.212:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]}
{"level":"info","ts":"2026-05-05T09:40:10.846212Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"}
{"level":"info","ts":"2026-05-05T09:40:10.846273Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.212:2380"}
{"level":"info","ts":"2026-05-05T09:40:10.846325Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.212:2380"}
{"level":"info","ts":"2026-05-05T09:40:11.40053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc is starting a new election at term 1"}
{"level":"info","ts":"2026-05-05T09:40:11.400608Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became pre-candidate at term 1"}
{"level":"info","ts":"2026-05-05T09:40:11.400664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgPreVoteResp from e1ab0380b9290bdc at term 1"}
{"level":"info","ts":"2026-05-05T09:40:11.400688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became candidate at term 2"}
{"level":"info","ts":"2026-05-05T09:40:11.400707Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc received MsgVoteResp from e1ab0380b9290bdc at term 2"}
{"level":"info","ts":"2026-05-05T09:40:11.400726Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e1ab0380b9290bdc became leader at term 2"}
{"level":"info","ts":"2026-05-05T09:40:11.40075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e1ab0380b9290bdc elected leader e1ab0380b9290bdc at term 2"}
{"level":"info","ts":"2026-05-05T09:40:11.401754Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e1ab0380b9290bdc","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.212:2379]}","request-path":"/0/members/e1ab0380b9290bdc/attributes","cluster-id":"a3ed131e36ad6843","publish-timeout":"7s"}
{"level":"info","ts":"2026-05-05T09:40:11.401955Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T09:40:11.402016Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"}
{"level":"info","ts":"2026-05-05T09:40:11.402119Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2026-05-05T09:40:11.402187Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2026-05-05T09:40:11.402229Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T09:40:11.403057Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"a3ed131e36ad6843","local-member-id":"e1ab0380b9290bdc","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T09:40:11.403181Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T09:40:11.403219Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"}
{"level":"info","ts":"2026-05-05T09:40:11.406597Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"}
{"level":"info","ts":"2026-05-05T09:40:11.407249Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.212:2379"}
{"level":"info","ts":"2026-05-05T09:40:15.563866Z","caller":"traceutil/trace.go:171","msg":"trace[1030051372] transaction","detail":"{read_only:false; response_revision:247; number_of_response:1; }","duration":"365.954679ms","start":"2026-05-05T09:40:15.19789Z","end":"2026-05-05T09:40:15.563845Z","steps":["trace[1030051372] 'process raft request'  (duration: 365.816054ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:40:15.56472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:40:15.197866Z","time spent":"366.189277ms","remote":"127.0.0.1:33590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3695,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/minions/instance\" mod_revision:27 > success:<request_put:<key:\"/registry/minions/instance\" value_size:3661 >> failure:<request_range:<key:\"/registry/minions/instance\" > >"}
{"level":"warn","ts":"2026-05-05T09:40:15.921377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.99667ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854731715663606068 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/secrets/kube-system/bootstrap-token-pidcug\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/bootstrap-token-pidcug\" value_size:465 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T09:40:15.921548Z","caller":"traceutil/trace.go:171","msg":"trace[859791043] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"347.026689ms","start":"2026-05-05T09:40:15.574503Z","end":"2026-05-05T09:40:15.92153Z","steps":["trace[859791043] 'process raft request'  (duration: 88.668888ms)","trace[859791043] 'compare'  (duration: 257.823364ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:40:15.92161Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:40:15.574475Z","time spent":"347.109102ms","remote":"127.0.0.1:33502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":525,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/kube-system/bootstrap-token-pidcug\" mod_revision:0 > success:<request_put:<key:\"/registry/secrets/kube-system/bootstrap-token-pidcug\" value_size:465 >> failure:<>"}
{"level":"info","ts":"2026-05-05T09:40:42.518703Z","caller":"traceutil/trace.go:171","msg":"trace[933330077] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"161.652217ms","start":"2026-05-05T09:40:42.35702Z","end":"2026-05-05T09:40:42.518672Z","steps":["trace[933330077] 'process raft request'  (duration: 161.486802ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.591685Z","caller":"traceutil/trace.go:171","msg":"trace[1631258336] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"232.205419ms","start":"2026-05-05T09:40:42.359429Z","end":"2026-05-05T09:40:42.591635Z","steps":["trace[1631258336] 'process raft request'  (duration: 231.569189ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.591743Z","caller":"traceutil/trace.go:171","msg":"trace[1957458083] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"220.857155ms","start":"2026-05-05T09:40:42.37085Z","end":"2026-05-05T09:40:42.591707Z","steps":["trace[1957458083] 'process raft request'  (duration: 220.72877ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.591747Z","caller":"traceutil/trace.go:171","msg":"trace[1982253986] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"232.18039ms","start":"2026-05-05T09:40:42.359504Z","end":"2026-05-05T09:40:42.591684Z","steps":["trace[1982253986] 'process raft request'  (duration: 232.038025ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.591937Z","caller":"traceutil/trace.go:171","msg":"trace[2050517183] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"149.811457ms","start":"2026-05-05T09:40:42.44209Z","end":"2026-05-05T09:40:42.591901Z","steps":["trace[2050517183] 'process raft request'  (duration: 149.765456ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.592074Z","caller":"traceutil/trace.go:171","msg":"trace[1395174779] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"179.159662ms","start":"2026-05-05T09:40:42.4129Z","end":"2026-05-05T09:40:42.592059Z","steps":["trace[1395174779] 'process raft request'  (duration: 178.864983ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.592133Z","caller":"traceutil/trace.go:171","msg":"trace[1538808767] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"179.174732ms","start":"2026-05-05T09:40:42.41295Z","end":"2026-05-05T09:40:42.592124Z","steps":["trace[1538808767] 'process raft request'  (duration: 178.855972ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.592184Z","caller":"traceutil/trace.go:171","msg":"trace[501379174] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"187.357646ms","start":"2026-05-05T09:40:42.404813Z","end":"2026-05-05T09:40:42.592171Z","steps":["trace[501379174] 'process raft request'  (duration: 186.898471ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.592204Z","caller":"traceutil/trace.go:171","msg":"trace[1587401133] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"203.231837ms","start":"2026-05-05T09:40:42.388966Z","end":"2026-05-05T09:40:42.592197Z","steps":["trace[1587401133] 'process raft request'  (duration: 202.646498ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.592096Z","caller":"traceutil/trace.go:171","msg":"trace[732447075] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"197.612967ms","start":"2026-05-05T09:40:42.394439Z","end":"2026-05-05T09:40:42.592052Z","steps":["trace[732447075] 'process raft request'  (duration: 197.233755ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:42.5923Z","caller":"traceutil/trace.go:171","msg":"trace[472562921] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"201.968956ms","start":"2026-05-05T09:40:42.390319Z","end":"2026-05-05T09:40:42.592288Z","steps":["trace[472562921] 'process raft request'  (duration: 201.326055ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:40:48.065127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.09385ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854731715663606794 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:1006 >> failure:<>>","response":"size:16"}
{"level":"info","ts":"2026-05-05T09:40:48.065274Z","caller":"traceutil/trace.go:171","msg":"trace[1063754064] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"292.161006ms","start":"2026-05-05T09:40:47.773088Z","end":"2026-05-05T09:40:48.065249Z","steps":["trace[1063754064] 'process raft request'  (duration: 118.841688ms)","trace[1063754064] 'compare'  (duration: 172.857533ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:40:48.868171Z","caller":"traceutil/trace.go:171","msg":"trace[1594560771] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"333.428033ms","start":"2026-05-05T09:40:48.534716Z","end":"2026-05-05T09:40:48.868145Z","steps":["trace[1594560771] 'read index received'  (duration: 332.538304ms)","trace[1594560771] 'applied index is now lower than readState.Index'  (duration: 888.249µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:40:48.868279Z","caller":"traceutil/trace.go:171","msg":"trace[948998765] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"366.658746ms","start":"2026-05-05T09:40:48.501571Z","end":"2026-05-05T09:40:48.86823Z","steps":["trace[948998765] 'process raft request'  (duration: 366.029335ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:40:48.868351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.597328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:40:48.868468Z","caller":"traceutil/trace.go:171","msg":"trace[1304472863] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:615; }","duration":"333.795584ms","start":"2026-05-05T09:40:48.534644Z","end":"2026-05-05T09:40:48.868439Z","steps":["trace[1304472863] 'agreement among raft nodes before linearized reading'  (duration: 333.595248ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:40:48.868515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:40:48.501542Z","time spent":"366.847312ms","remote":"127.0.0.1:33502","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" mod_revision:609 > success:<request_put:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" value_size:1036177 >> failure:<request_range:<key:\"/registry/secrets/envoy-gateway-system/sh.helm.release.v1.envoy-gateway.v1\" > >"}
{"level":"warn","ts":"2026-05-05T09:40:48.86857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:40:48.534611Z","time spent":"333.948089ms","remote":"127.0.0.1:33432","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-05-05T09:40:48.868753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.929566ms","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-05-05T09:40:48.868851Z","caller":"traceutil/trace.go:171","msg":"trace[967745778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"147.091151ms","start":"2026-05-05T09:40:48.721726Z","end":"2026-05-05T09:40:48.868817Z","steps":["trace[967745778] 'agreement among raft nodes before linearized reading'  (duration: 146.572725ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:40:49.478934Z","caller":"traceutil/trace.go:171","msg":"trace[255674874] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"454.135819ms","start":"2026-05-05T09:40:49.024771Z","end":"2026-05-05T09:40:49.478906Z","steps":["trace[255674874] 'read index received'  (duration: 435.448945ms)","trace[255674874] 'applied index is now lower than readState.Index'  (duration: 18.685814ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:40:49.479052Z","caller":"traceutil/trace.go:171","msg":"trace[1394310527] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"545.44536ms","start":"2026-05-05T09:40:48.933594Z","end":"2026-05-05T09:40:49.479039Z","steps":["trace[1394310527] 'process raft request'  (duration: 526.671053ms)","trace[1394310527] 'compare'  (duration: 18.524269ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:40:49.479127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:40:48.933571Z","time spent":"545.503821ms","remote":"127.0.0.1:33764","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" mod_revision:0 > success:<request_put:<key:\"/registry/clusterrolebindings/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" value_size:994 >> failure:<>"}
{"level":"warn","ts":"2026-05-05T09:40:49.479158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.042943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-05T09:40:49.479226Z","caller":"traceutil/trace.go:171","msg":"trace[265917583] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:617; }","duration":"143.160707ms","start":"2026-05-05T09:40:49.336052Z","end":"2026-05-05T09:40:49.479213Z","steps":["trace[265917583] 'agreement among raft nodes before linearized reading'  (duration: 143.016242ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:40:49.479519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.750048ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wnc4j\" ","response":"range_response_count:1 size:16965"}
{"level":"info","ts":"2026-05-05T09:40:49.479554Z","caller":"traceutil/trace.go:171","msg":"trace[359181678] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wnc4j; range_end:; response_count:1; response_revision:617; }","duration":"454.824071ms","start":"2026-05-05T09:40:49.024722Z","end":"2026-05-05T09:40:49.479546Z","steps":["trace[359181678] 'agreement among raft nodes before linearized reading'  (duration: 454.697257ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:40:49.479576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:40:49.024704Z","time spent":"454.867382ms","remote":"127.0.0.1:33604","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-wnc4j\" "}
{"level":"info","ts":"2026-05-05T09:41:04.921841Z","caller":"traceutil/trace.go:171","msg":"trace[1236013962] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"226.854037ms","start":"2026-05-05T09:41:04.694936Z","end":"2026-05-05T09:41:04.92179Z","steps":["trace[1236013962] 'process raft request'  (duration: 209.010356ms)","trace[1236013962] 'compare'  (duration: 17.641893ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:41:33.278819Z","caller":"traceutil/trace.go:171","msg":"trace[811094139] linearizableReadLoop","detail":"{readStateIndex:1216; appliedIndex:1215; }","duration":"180.54627ms","start":"2026-05-05T09:41:33.098253Z","end":"2026-05-05T09:41:33.278799Z","steps":["trace[811094139] 'read index received'  (duration: 180.339288ms)","trace[811094139] 'applied index is now lower than readState.Index'  (duration: 206.162µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:41:33.278928Z","caller":"traceutil/trace.go:171","msg":"trace[796096635] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"187.41067ms","start":"2026-05-05T09:41:33.091483Z","end":"2026-05-05T09:41:33.278893Z","steps":["trace[796096635] 'process raft request'  (duration: 187.173288ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:41:33.279098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.768442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"}
{"level":"info","ts":"2026-05-05T09:41:33.279156Z","caller":"traceutil/trace.go:171","msg":"trace[2068871163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1182; }","duration":"180.907794ms","start":"2026-05-05T09:41:33.098217Z","end":"2026-05-05T09:41:33.279125Z","steps":["trace[2068871163] 'agreement among raft nodes before linearized reading'  (duration: 180.695102ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:41:58.602812Z","caller":"traceutil/trace.go:171","msg":"trace[1593525885] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"154.607612ms","start":"2026-05-05T09:41:58.448169Z","end":"2026-05-05T09:41:58.602777Z","steps":["trace[1593525885] 'process raft request'  (duration: 154.375099ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:42:07.673189Z","caller":"traceutil/trace.go:171","msg":"trace[624159122] transaction","detail":"{read_only:false; response_revision:1562; number_of_response:1; }","duration":"114.150057ms","start":"2026-05-05T09:42:07.559003Z","end":"2026-05-05T09:42:07.673153Z","steps":["trace[624159122] 'process raft request'  (duration: 50.186506ms)","trace[624159122] 'compare'  (duration: 63.83844ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:42:38.01788Z","caller":"traceutil/trace.go:171","msg":"trace[1006814056] transaction","detail":"{read_only:false; response_revision:1981; number_of_response:1; }","duration":"106.584506ms","start":"2026-05-05T09:42:37.911267Z","end":"2026-05-05T09:42:38.017851Z","steps":["trace[1006814056] 'process raft request'  (duration: 103.454299ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:42:38.234437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.881329ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854731715663609545 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/kube-controller-manager\" mod_revision:1971 > success:<request_put:<key:\"/registry/leases/kube-system/kube-controller-manager\" value_size:429 >> failure:<request_range:<key:\"/registry/leases/kube-system/kube-controller-manager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T09:42:38.234594Z","caller":"traceutil/trace.go:171","msg":"trace[1230812327] linearizableReadLoop","detail":"{readStateIndex:2057; appliedIndex:2056; }","duration":"129.562385ms","start":"2026-05-05T09:42:38.105007Z","end":"2026-05-05T09:42:38.234569Z","steps":["trace[1230812327] 'read index received'  (duration: 21.30205ms)","trace[1230812327] 'applied index is now lower than readState.Index'  (duration: 108.258385ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:42:38.234793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.788759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"}
{"level":"info","ts":"2026-05-05T09:42:38.23485Z","caller":"traceutil/trace.go:171","msg":"trace[326639507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1982; }","duration":"129.84357ms","start":"2026-05-05T09:42:38.104994Z","end":"2026-05-05T09:42:38.234837Z","steps":["trace[326639507] 'agreement among raft nodes before linearized reading'  (duration: 129.640336ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:42:38.234829Z","caller":"traceutil/trace.go:171","msg":"trace[557736047] transaction","detail":"{read_only:false; response_revision:1982; number_of_response:1; }","duration":"130.196406ms","start":"2026-05-05T09:42:38.104584Z","end":"2026-05-05T09:42:38.23478Z","steps":["trace[557736047] 'process raft request'  (duration: 21.823048ms)","trace[557736047] 'compare'  (duration: 107.595204ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:42:39.230306Z","caller":"traceutil/trace.go:171","msg":"trace[1516907396] transaction","detail":"{read_only:false; response_revision:1992; number_of_response:1; }","duration":"183.10196ms","start":"2026-05-05T09:42:39.047173Z","end":"2026-05-05T09:42:39.230275Z","steps":["trace[1516907396] 'process raft request'  (duration: 182.846726ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:43:11.908829Z","caller":"traceutil/trace.go:171","msg":"trace[647888217] transaction","detail":"{read_only:false; response_revision:2178; number_of_response:1; }","duration":"149.559108ms","start":"2026-05-05T09:43:11.75924Z","end":"2026-05-05T09:43:11.908799Z","steps":["trace[647888217] 'process raft request'  (duration: 149.379125ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:43:54.012068Z","caller":"traceutil/trace.go:171","msg":"trace[663763892] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"100.441782ms","start":"2026-05-05T09:43:53.911601Z","end":"2026-05-05T09:43:54.012043Z","steps":["trace[663763892] 'process raft request'  (duration: 100.312298ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:44:25.488559Z","caller":"traceutil/trace.go:171","msg":"trace[855661392] transaction","detail":"{read_only:false; response_revision:2687; number_of_response:1; }","duration":"136.606256ms","start":"2026-05-05T09:44:25.351892Z","end":"2026-05-05T09:44:25.488498Z","steps":["trace[855661392] 'process raft request'  (duration: 136.053461ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:44:30.97104Z","caller":"traceutil/trace.go:171","msg":"trace[311344783] linearizableReadLoop","detail":"{readStateIndex:2814; appliedIndex:2813; }","duration":"262.850854ms","start":"2026-05-05T09:44:30.708105Z","end":"2026-05-05T09:44:30.970956Z","steps":["trace[311344783] 'read index received'  (duration: 262.68409ms)","trace[311344783] 'applied index is now lower than readState.Index'  (duration: 165.454µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:44:30.971093Z","caller":"traceutil/trace.go:171","msg":"trace[1718557700] transaction","detail":"{read_only:false; response_revision:2713; number_of_response:1; }","duration":"263.922251ms","start":"2026-05-05T09:44:30.707126Z","end":"2026-05-05T09:44:30.971048Z","steps":["trace[1718557700] 'process raft request'  (duration: 263.650894ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:30.971753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.066639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:44:30.971832Z","caller":"traceutil/trace.go:171","msg":"trace[693295574] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2713; }","duration":"263.733666ms","start":"2026-05-05T09:44:30.708075Z","end":"2026-05-05T09:44:30.971809Z","steps":["trace[693295574] 'agreement among raft nodes before linearized reading'  (duration: 263.0687ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:44:31.20527Z","caller":"traceutil/trace.go:171","msg":"trace[1121085273] linearizableReadLoop","detail":"{readStateIndex:2815; appliedIndex:2814; }","duration":"234.12939ms","start":"2026-05-05T09:44:30.971115Z","end":"2026-05-05T09:44:31.205245Z","steps":["trace[1121085273] 'read index received'  (duration: 233.939186ms)","trace[1121085273] 'applied index is now lower than readState.Index'  (duration: 189.314µs)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:44:31.205535Z","caller":"traceutil/trace.go:171","msg":"trace[1650638138] transaction","detail":"{read_only:false; response_revision:2714; number_of_response:1; }","duration":"285.26247ms","start":"2026-05-05T09:44:30.920259Z","end":"2026-05-05T09:44:31.205521Z","steps":["trace[1650638138] 'process raft request'  (duration: 284.85709ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:31.205743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T09:44:31.205786Z","caller":"traceutil/trace.go:171","msg":"trace[1327518385] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:2714; }","duration":"308.537533ms","start":"2026-05-05T09:44:30.897238Z","end":"2026-05-05T09:44:31.205775Z","steps":["trace[1327518385] 'agreement among raft nodes before linearized reading'  (duration: 308.451201ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:31.205822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:44:30.897219Z","time spent":"308.589335ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":14,"response size":31,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T09:44:31.206016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.451871ms","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-05-05T09:44:31.206096Z","caller":"traceutil/trace.go:171","msg":"trace[1131219942] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2714; }","duration":"450.542104ms","start":"2026-05-05T09:44:30.755537Z","end":"2026-05-05T09:44:31.206079Z","steps":["trace[1131219942] 'agreement among raft nodes before linearized reading'  (duration: 450.35228ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:31.20615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:44:30.755531Z","time spent":"450.607426ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "}
{"level":"warn","ts":"2026-05-05T09:44:31.206284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.496262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T09:44:31.206339Z","caller":"traceutil/trace.go:171","msg":"trace[100320540] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:2714; }","duration":"402.553554ms","start":"2026-05-05T09:44:30.80377Z","end":"2026-05-05T09:44:31.206323Z","steps":["trace[100320540] 'agreement among raft nodes before linearized reading'  (duration: 402.473832ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:31.206383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:44:30.803754Z","time spent":"402.615376ms","remote":"127.0.0.1:51432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":31,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T09:44:31.206582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.596707ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:44:31.206728Z","caller":"traceutil/trace.go:171","msg":"trace[516972941] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2714; }","duration":"231.793652ms","start":"2026-05-05T09:44:30.974909Z","end":"2026-05-05T09:44:31.206703Z","steps":["trace[516972941] 'agreement among raft nodes before linearized reading'  (duration: 231.540066ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:31.207587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.073703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"}
{"level":"info","ts":"2026-05-05T09:44:31.207665Z","caller":"traceutil/trace.go:171","msg":"trace[1618447025] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2714; }","duration":"452.197956ms","start":"2026-05-05T09:44:30.75545Z","end":"2026-05-05T09:44:31.207648Z","steps":["trace[1618447025] 'agreement among raft nodes before linearized reading'  (duration: 451.416756ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:31.207721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:44:30.755433Z","time spent":"452.276407ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}
{"level":"info","ts":"2026-05-05T09:44:31.373538Z","caller":"traceutil/trace.go:171","msg":"trace[491726426] transaction","detail":"{read_only:false; response_revision:2716; number_of_response:1; }","duration":"160.572379ms","start":"2026-05-05T09:44:31.212927Z","end":"2026-05-05T09:44:31.373499Z","steps":["trace[491726426] 'process raft request'  (duration: 160.493277ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:44:31.374066Z","caller":"traceutil/trace.go:171","msg":"trace[1713501440] linearizableReadLoop","detail":"{readStateIndex:2816; appliedIndex:2815; }","duration":"161.610486ms","start":"2026-05-05T09:44:31.212432Z","end":"2026-05-05T09:44:31.374043Z","steps":["trace[1713501440] 'read index received'  (duration: 151.58884ms)","trace[1713501440] 'applied index is now lower than readState.Index'  (duration: 10.019136ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:44:31.374975Z","caller":"traceutil/trace.go:171","msg":"trace[21554842] transaction","detail":"{read_only:false; response_revision:2715; number_of_response:1; }","duration":"162.690943ms","start":"2026-05-05T09:44:31.212225Z","end":"2026-05-05T09:44:31.374916Z","steps":["trace[21554842] 'process raft request'  (duration: 151.801166ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:44:31.375382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.634212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-05-05T09:44:31.375546Z","caller":"traceutil/trace.go:171","msg":"trace[1338422518] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2716; }","duration":"163.120704ms","start":"2026-05-05T09:44:31.212405Z","end":"2026-05-05T09:44:31.375526Z","steps":["trace[1338422518] 'agreement among raft nodes before linearized reading'  (duration: 161.712989ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:47:39.286824Z","caller":"traceutil/trace.go:171","msg":"trace[298345089] transaction","detail":"{read_only:false; response_revision:3874; number_of_response:1; }","duration":"113.580056ms","start":"2026-05-05T09:47:39.17322Z","end":"2026-05-05T09:47:39.286801Z","steps":["trace[298345089] 'process raft request'  (duration: 113.445012ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:47:39.346084Z","caller":"traceutil/trace.go:171","msg":"trace[1938016839] transaction","detail":"{read_only:false; number_of_response:0; response_revision:3874; }","duration":"151.368796ms","start":"2026-05-05T09:47:39.194691Z","end":"2026-05-05T09:47:39.346059Z","steps":["trace[1938016839] 'process raft request'  (duration: 151.190261ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:01.873198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.131995ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854731715663615326 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" mod_revision:4008 > success:<request_put:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" value_size:411 >> failure:<request_range:<key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T09:48:01.873682Z","caller":"traceutil/trace.go:171","msg":"trace[153900915] transaction","detail":"{read_only:false; response_revision:4321; number_of_response:1; }","duration":"182.435041ms","start":"2026-05-05T09:48:01.691228Z","end":"2026-05-05T09:48:01.873663Z","steps":["trace[153900915] 'process raft request'  (duration: 182.087211ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:01.873865Z","caller":"traceutil/trace.go:171","msg":"trace[474721353] transaction","detail":"{read_only:false; response_revision:4320; number_of_response:1; }","duration":"199.512006ms","start":"2026-05-05T09:48:01.674261Z","end":"2026-05-05T09:48:01.873773Z","steps":["trace[474721353] 'process raft request'  (duration: 20.673741ms)","trace[474721353] 'compare'  (duration: 178.00357ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:01.906128Z","caller":"traceutil/trace.go:171","msg":"trace[1461435027] transaction","detail":"{read_only:false; response_revision:4322; number_of_response:1; }","duration":"209.192741ms","start":"2026-05-05T09:48:01.696872Z","end":"2026-05-05T09:48:01.906064Z","steps":["trace[1461435027] 'process raft request'  (duration: 209.022746ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:01.906199Z","caller":"traceutil/trace.go:171","msg":"trace[478451229] transaction","detail":"{read_only:false; response_revision:4323; number_of_response:1; }","duration":"151.722474ms","start":"2026-05-05T09:48:01.754447Z","end":"2026-05-05T09:48:01.906169Z","steps":["trace[478451229] 'process raft request'  (duration: 151.530478ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:01.906199Z","caller":"traceutil/trace.go:171","msg":"trace[99538834] transaction","detail":"{read_only:false; response_revision:4325; number_of_response:1; }","duration":"115.234725ms","start":"2026-05-05T09:48:01.790947Z","end":"2026-05-05T09:48:01.906182Z","steps":["trace[99538834] 'process raft request'  (duration: 115.142283ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:01.906251Z","caller":"traceutil/trace.go:171","msg":"trace[1917054758] transaction","detail":"{read_only:false; response_revision:4324; number_of_response:1; }","duration":"126.491168ms","start":"2026-05-05T09:48:01.779714Z","end":"2026-05-05T09:48:01.906205Z","steps":["trace[1917054758] 'process raft request'  (duration: 126.330163ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:02.131979Z","caller":"traceutil/trace.go:171","msg":"trace[199243900] transaction","detail":"{read_only:false; response_revision:4326; number_of_response:1; }","duration":"221.467106ms","start":"2026-05-05T09:48:01.910475Z","end":"2026-05-05T09:48:02.131942Z","steps":["trace[199243900] 'process raft request'  (duration: 158.235466ms)","trace[199243900] 'compare'  (duration: 62.89973ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:02.132143Z","caller":"traceutil/trace.go:171","msg":"trace[1561592308] linearizableReadLoop","detail":"{readStateIndex:4492; appliedIndex:4491; }","duration":"218.733625ms","start":"2026-05-05T09:48:01.913379Z","end":"2026-05-05T09:48:02.132112Z","steps":["trace[1561592308] 'read index received'  (duration: 155.346301ms)","trace[1561592308] 'applied index is now lower than readState.Index'  (duration: 63.385004ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:48:02.132459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.058005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-tls\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:48:02.132549Z","caller":"traceutil/trace.go:171","msg":"trace[1762663432] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-tls; range_end:; response_count:0; response_revision:4326; }","duration":"219.198909ms","start":"2026-05-05T09:48:01.913333Z","end":"2026-05-05T09:48:02.132532Z","steps":["trace[1762663432] 'agreement among raft nodes before linearized reading'  (duration: 218.90285ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:02.133282Z","caller":"traceutil/trace.go:171","msg":"trace[641306420] transaction","detail":"{read_only:false; response_revision:4327; number_of_response:1; }","duration":"183.080811ms","start":"2026-05-05T09:48:01.950177Z","end":"2026-05-05T09:48:02.133258Z","steps":["trace[641306420] 'process raft request'  (duration: 181.610368ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:02.262728Z","caller":"traceutil/trace.go:171","msg":"trace[1631467924] transaction","detail":"{read_only:false; response_revision:4331; number_of_response:1; }","duration":"100.686276ms","start":"2026-05-05T09:48:02.162013Z","end":"2026-05-05T09:48:02.262699Z","steps":["trace[1631467924] 'process raft request'  (duration: 100.4709ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:09.556862Z","caller":"traceutil/trace.go:171","msg":"trace[417394777] linearizableReadLoop","detail":"{readStateIndex:4635; appliedIndex:4633; }","duration":"129.482794ms","start":"2026-05-05T09:48:09.427361Z","end":"2026-05-05T09:48:09.556844Z","steps":["trace[417394777] 'read index received'  (duration: 10.531112ms)","trace[417394777] 'applied index is now lower than readState.Index'  (duration: 118.950841ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:09.5571Z","caller":"traceutil/trace.go:171","msg":"trace[847475311] transaction","detail":"{read_only:false; response_revision:4463; number_of_response:1; }","duration":"133.190464ms","start":"2026-05-05T09:48:09.423862Z","end":"2026-05-05T09:48:09.557052Z","steps":["trace[847475311] 'process raft request'  (duration: 132.937606ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:09.557247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.868716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:48:09.557988Z","caller":"traceutil/trace.go:171","msg":"trace[1414706310] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:0; response_revision:4463; }","duration":"130.645548ms","start":"2026-05-05T09:48:09.427323Z","end":"2026-05-05T09:48:09.557969Z","steps":["trace[1414706310] 'agreement among raft nodes before linearized reading'  (duration: 129.880746ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:09.557488Z","caller":"traceutil/trace.go:171","msg":"trace[130044997] transaction","detail":"{read_only:false; response_revision:4462; number_of_response:1; }","duration":"139.906503ms","start":"2026-05-05T09:48:09.417571Z","end":"2026-05-05T09:48:09.557477Z","steps":["trace[130044997] 'process raft request'  (duration: 97.164207ms)","trace[130044997] 'compare'  (duration: 41.926201ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:10.041921Z","caller":"traceutil/trace.go:171","msg":"trace[1988628482] transaction","detail":"{read_only:false; response_revision:4474; number_of_response:1; }","duration":"304.382544ms","start":"2026-05-05T09:48:09.737519Z","end":"2026-05-05T09:48:10.041901Z","steps":["trace[1988628482] 'process raft request'  (duration: 304.207208ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:10.042035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:09.737502Z","time spent":"304.479517ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":240655,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/configmaps/monitoring/prometheus-kube-prometheus-stack-prometheus-rulefiles-0\" mod_revision:0 > success:<request_put:<key:\"/registry/configmaps/monitoring/prometheus-kube-prometheus-stack-prometheus-rulefiles-0\" value_size:240558 >> failure:<>"}
{"level":"info","ts":"2026-05-05T09:48:10.051768Z","caller":"traceutil/trace.go:171","msg":"trace[1257883227] transaction","detail":"{read_only:false; response_revision:4475; number_of_response:1; }","duration":"311.941827ms","start":"2026-05-05T09:48:09.739795Z","end":"2026-05-05T09:48:10.051737Z","steps":["trace[1257883227] 'process raft request'  (duration: 311.418612ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:10.051914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:09.739784Z","time spent":"312.04782ms","remote":"127.0.0.1:59756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4722,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" mod_revision:4461 > success:<request_put:<key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" value_size:4623 >> failure:<request_range:<key:\"/registry/monitoring.coreos.com/alertmanagers/monitoring/kube-prometheus-stack-alertmanager\" > >"}
{"level":"info","ts":"2026-05-05T09:48:10.051968Z","caller":"traceutil/trace.go:171","msg":"trace[776373806] transaction","detail":"{read_only:false; response_revision:4476; number_of_response:1; }","duration":"311.590787ms","start":"2026-05-05T09:48:09.740352Z","end":"2026-05-05T09:48:10.051943Z","steps":["trace[776373806] 'process raft request'  (duration: 311.026981ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:10.052774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:09.740341Z","time spent":"312.404771ms","remote":"127.0.0.1:33572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1022,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" mod_revision:0 > success:<request_put:<key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" value_size:869 >> failure:<>"}
{"level":"info","ts":"2026-05-05T09:48:10.060526Z","caller":"traceutil/trace.go:171","msg":"trace[964931232] transaction","detail":"{read_only:false; response_revision:4477; number_of_response:1; }","duration":"130.71151ms","start":"2026-05-05T09:48:09.9298Z","end":"2026-05-05T09:48:10.060511Z","steps":["trace[964931232] 'process raft request'  (duration: 130.391141ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:10.060688Z","caller":"traceutil/trace.go:171","msg":"trace[174785934] linearizableReadLoop","detail":"{readStateIndex:4648; appliedIndex:4645; }","duration":"319.958415ms","start":"2026-05-05T09:48:09.740723Z","end":"2026-05-05T09:48:10.060682Z","steps":["trace[174785934] 'read index received'  (duration: 301.058485ms)","trace[174785934] 'applied index is now lower than readState.Index'  (duration: 18.89919ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:48:10.060923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.184241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1131"}
{"level":"info","ts":"2026-05-05T09:48:10.06097Z","caller":"traceutil/trace.go:171","msg":"trace[330102708] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4478; }","duration":"320.281834ms","start":"2026-05-05T09:48:09.740677Z","end":"2026-05-05T09:48:10.060959Z","steps":["trace[330102708] 'agreement among raft nodes before linearized reading'  (duration: 320.14447ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:10.060976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.643435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-05-05T09:48:10.060997Z","caller":"traceutil/trace.go:171","msg":"trace[1969712885] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4478; }","duration":"114.707877ms","start":"2026-05-05T09:48:09.946283Z","end":"2026-05-05T09:48:10.060991Z","steps":["trace[1969712885] 'agreement among raft nodes before linearized reading'  (duration: 114.603334ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:10.061002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:09.740657Z","time spent":"320.335536ms","remote":"127.0.0.1:33502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1155,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "}
{"level":"warn","ts":"2026-05-05T09:48:10.064589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.141232ms","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-05-05T09:48:10.064661Z","caller":"traceutil/trace.go:171","msg":"trace[176944152] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4478; }","duration":"162.262406ms","start":"2026-05-05T09:48:09.902382Z","end":"2026-05-05T09:48:10.064645Z","steps":["trace[176944152] 'agreement among raft nodes before linearized reading'  (duration: 158.417941ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:10.939101Z","caller":"traceutil/trace.go:171","msg":"trace[1773932044] transaction","detail":"{read_only:false; response_revision:4537; number_of_response:1; }","duration":"120.19846ms","start":"2026-05-05T09:48:10.818858Z","end":"2026-05-05T09:48:10.939056Z","steps":["trace[1773932044] 'process raft request'  (duration: 115.750438ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:11.39744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.582205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b9273252-4dfb-4ed7-b02b-2e10c2657721\" ","response":"range_response_count:1 size:3760"}
{"level":"info","ts":"2026-05-05T09:48:11.39752Z","caller":"traceutil/trace.go:171","msg":"trace[1895174347] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b9273252-4dfb-4ed7-b02b-2e10c2657721; range_end:; response_count:1; response_revision:4543; }","duration":"139.697158ms","start":"2026-05-05T09:48:11.257803Z","end":"2026-05-05T09:48:11.397501Z","steps":["trace[1895174347] 'range keys from in-memory index tree'  (duration: 139.443381ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:11.398847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.971098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2194901"}
{"level":"info","ts":"2026-05-05T09:48:11.398932Z","caller":"traceutil/trace.go:171","msg":"trace[1398225796] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4543; }","duration":"110.088961ms","start":"2026-05-05T09:48:11.288812Z","end":"2026-05-05T09:48:11.398901Z","steps":["trace[1398225796] 'range keys from in-memory index tree'  (duration: 108.271256ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:16.782261Z","caller":"traceutil/trace.go:171","msg":"trace[1766806343] transaction","detail":"{read_only:false; response_revision:4631; number_of_response:1; }","duration":"105.903311ms","start":"2026-05-05T09:48:16.676333Z","end":"2026-05-05T09:48:16.782236Z","steps":["trace[1766806343] 'process raft request'  (duration: 85.678941ms)","trace[1766806343] 'compare'  (duration: 20.114577ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:48:17.84832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.24883ms","expected-duration":"100ms","prefix":"","request":"header:<ID:854731715663616119 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/services/endpoints/monitoring/kube-prometheus-stack-alertmanager\" mod_revision:4109 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/kube-prometheus-stack-alertmanager\" value_size:1200 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/kube-prometheus-stack-alertmanager\" > >>","response":"size:16"}
{"level":"info","ts":"2026-05-05T09:48:17.848664Z","caller":"traceutil/trace.go:171","msg":"trace[1539065847] linearizableReadLoop","detail":"{readStateIndex:4858; appliedIndex:4854; }","duration":"509.183276ms","start":"2026-05-05T09:48:17.339463Z","end":"2026-05-05T09:48:17.848647Z","steps":["trace[1539065847] 'read index received'  (duration: 334.507054ms)","trace[1539065847] 'applied index is now lower than readState.Index'  (duration: 174.675202ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:17.848892Z","caller":"traceutil/trace.go:171","msg":"trace[1333933572] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"537.459915ms","start":"2026-05-05T09:48:17.311364Z","end":"2026-05-05T09:48:17.848824Z","steps":["trace[1333933572] 'process raft request'  (duration: 537.168317ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:17.848979Z","caller":"traceutil/trace.go:171","msg":"trace[1163465884] transaction","detail":"{read_only:false; response_revision:4684; number_of_response:1; }","duration":"532.328284ms","start":"2026-05-05T09:48:17.316638Z","end":"2026-05-05T09:48:17.848966Z","steps":["trace[1163465884] 'process raft request'  (duration: 531.955823ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:17.849062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.316627Z","time spent":"532.395455ms","remote":"127.0.0.1:33604","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16539,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" mod_revision:4590 > success:<request_put:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" value_size:16458 >> failure:<request_range:<key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" > >"}
{"level":"warn","ts":"2026-05-05T09:48:17.849374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.902638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" ","response":"range_response_count:1 size:1817"}
{"level":"info","ts":"2026-05-05T09:48:17.849395Z","caller":"traceutil/trace.go:171","msg":"trace[1689924892] transaction","detail":"{read_only:false; response_revision:4681; number_of_response:1; }","duration":"538.691713ms","start":"2026-05-05T09:48:17.310685Z","end":"2026-05-05T09:48:17.849377Z","steps":["trace[1689924892] 'process raft request'  (duration: 363.273818ms)","trace[1689924892] 'compare'  (duration: 174.079384ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:17.849429Z","caller":"traceutil/trace.go:171","msg":"trace[1098966563] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-admission; range_end:; response_count:1; response_revision:4684; }","duration":"509.983011ms","start":"2026-05-05T09:48:17.339431Z","end":"2026-05-05T09:48:17.849414Z","steps":["trace[1098966563] 'agreement among raft nodes before linearized reading'  (duration: 509.833845ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:17.849467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.339389Z","time spent":"510.070443ms","remote":"127.0.0.1:33502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":1841,"request content":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-admission\" "}
{"level":"info","ts":"2026-05-05T09:48:17.849664Z","caller":"traceutil/trace.go:171","msg":"trace[1666320411] transaction","detail":"{read_only:false; response_revision:4682; number_of_response:1; }","duration":"538.776924ms","start":"2026-05-05T09:48:17.310867Z","end":"2026-05-05T09:48:17.849644Z","steps":["trace[1666320411] 'process raft request'  (duration: 537.555318ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:17.84978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.310862Z","time spent":"538.854928ms","remote":"127.0.0.1:33666","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1868,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/endpointslices/monitoring/kube-prometheus-stack-alertmanager-bpgxf\" mod_revision:4110 > success:<request_put:<key:\"/registry/endpointslices/monitoring/kube-prometheus-stack-alertmanager-bpgxf\" value_size:1784 >> failure:<request_range:<key:\"/registry/endpointslices/monitoring/kube-prometheus-stack-alertmanager-bpgxf\" > >"}
{"level":"warn","ts":"2026-05-05T09:48:17.850159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.311355Z","time spent":"537.6131ms","remote":"127.0.0.1:33584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":905,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/monitoring/alertmanager-operated\" mod_revision:4470 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/alertmanager-operated\" value_size:836 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/alertmanager-operated\" > >"}
{"level":"warn","ts":"2026-05-05T09:48:17.849509Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.310667Z","time spent":"538.776635ms","remote":"127.0.0.1:33584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1282,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/services/endpoints/monitoring/kube-prometheus-stack-alertmanager\" mod_revision:4109 > success:<request_put:<key:\"/registry/services/endpoints/monitoring/kube-prometheus-stack-alertmanager\" value_size:1200 >> failure:<request_range:<key:\"/registry/services/endpoints/monitoring/kube-prometheus-stack-alertmanager\" > >"}
{"level":"info","ts":"2026-05-05T09:48:17.894805Z","caller":"traceutil/trace.go:171","msg":"trace[1235519309] transaction","detail":"{read_only:false; response_revision:4686; number_of_response:1; }","duration":"328.580579ms","start":"2026-05-05T09:48:17.56619Z","end":"2026-05-05T09:48:17.894771Z","steps":["trace[1235519309] 'process raft request'  (duration: 328.471206ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:17.894952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.373092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T09:48:17.895086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.566174Z","time spent":"328.707773ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" mod_revision:4478 > success:<request_put:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" value_size:415 >> failure:<request_range:<key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" > >"}
{"level":"info","ts":"2026-05-05T09:48:17.895125Z","caller":"traceutil/trace.go:171","msg":"trace[923511901] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:4686; }","duration":"356.556908ms","start":"2026-05-05T09:48:17.538507Z","end":"2026-05-05T09:48:17.895064Z","steps":["trace[923511901] 'agreement among raft nodes before linearized reading'  (duration: 356.337961ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:17.895215Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.538489Z","time spent":"356.681882ms","remote":"127.0.0.1:33810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T09:48:17.895243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.671792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T09:48:17.895226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.073481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"}
{"level":"info","ts":"2026-05-05T09:48:17.895368Z","caller":"traceutil/trace.go:171","msg":"trace[1636486733] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4686; }","duration":"359.833736ms","start":"2026-05-05T09:48:17.535518Z","end":"2026-05-05T09:48:17.895351Z","steps":["trace[1636486733] 'agreement among raft nodes before linearized reading'  (duration: 359.668001ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:17.895458Z","caller":"traceutil/trace.go:171","msg":"trace[1882036777] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4686; }","duration":"126.311398ms","start":"2026-05-05T09:48:17.769084Z","end":"2026-05-05T09:48:17.895395Z","steps":["trace[1882036777] 'agreement among raft nodes before linearized reading'  (duration: 125.71656ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:17.895471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.535499Z","time spent":"359.961059ms","remote":"127.0.0.1:33418","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-05-05T09:48:17.895565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.454131ms","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-05-05T09:48:17.895649Z","caller":"traceutil/trace.go:171","msg":"trace[1346613651] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4686; }","duration":"159.573694ms","start":"2026-05-05T09:48:17.736049Z","end":"2026-05-05T09:48:17.895622Z","steps":["trace[1346613651] 'agreement among raft nodes before linearized reading'  (duration: 159.013848ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:17.895045Z","caller":"traceutil/trace.go:171","msg":"trace[1807975318] transaction","detail":"{read_only:false; response_revision:4685; number_of_response:1; }","duration":"498.574762ms","start":"2026-05-05T09:48:17.396446Z","end":"2026-05-05T09:48:17.895021Z","steps":["trace[1807975318] 'process raft request'  (duration: 497.83841ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:17.896054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:17.396425Z","time spent":"499.480609ms","remote":"127.0.0.1:51462","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2228,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-5e528fd3-d6b1-4707-8b89-2a13ab036429\" mod_revision:0 > success:<request_put:<key:\"/registry/cilium.io/ciliumendpoints/local-path-storage/helper-pod-create-pvc-5e528fd3-d6b1-4707-8b89-2a13ab036429\" value_size:2107 >> failure:<>"}
{"level":"info","ts":"2026-05-05T09:48:18.07081Z","caller":"traceutil/trace.go:171","msg":"trace[180932986] transaction","detail":"{read_only:false; response_revision:4687; number_of_response:1; }","duration":"214.67025ms","start":"2026-05-05T09:48:17.856111Z","end":"2026-05-05T09:48:18.070782Z","steps":["trace[180932986] 'process raft request'  (duration: 149.479695ms)","trace[180932986] 'compare'  (duration: 64.821133ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:18.07141Z","caller":"traceutil/trace.go:171","msg":"trace[1211212278] transaction","detail":"{read_only:false; response_revision:4689; number_of_response:1; }","duration":"215.213366ms","start":"2026-05-05T09:48:17.856181Z","end":"2026-05-05T09:48:18.071394Z","steps":["trace[1211212278] 'process raft request'  (duration: 214.865006ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:18.07329Z","caller":"traceutil/trace.go:171","msg":"trace[438331484] transaction","detail":"{read_only:false; response_revision:4692; number_of_response:1; }","duration":"170.822619ms","start":"2026-05-05T09:48:17.900564Z","end":"2026-05-05T09:48:18.071386Z","steps":["trace[438331484] 'process raft request'  (duration: 170.774807ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:18.073649Z","caller":"traceutil/trace.go:171","msg":"trace[1307647630] transaction","detail":"{read_only:false; response_revision:4690; number_of_response:1; }","duration":"217.38339ms","start":"2026-05-05T09:48:17.856248Z","end":"2026-05-05T09:48:18.073631Z","steps":["trace[1307647630] 'process raft request'  (duration: 214.865346ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:18.07386Z","caller":"traceutil/trace.go:171","msg":"trace[1684846540] linearizableReadLoop","detail":"{readStateIndex:4864; appliedIndex:4860; }","duration":"179.082953ms","start":"2026-05-05T09:48:17.894744Z","end":"2026-05-05T09:48:18.073827Z","steps":["trace[1684846540] 'read index received'  (duration: 110.94466ms)","trace[1684846540] 'applied index is now lower than readState.Index'  (duration: 68.136073ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:18.074093Z","caller":"traceutil/trace.go:171","msg":"trace[1073462578] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"173.651472ms","start":"2026-05-05T09:48:17.900427Z","end":"2026-05-05T09:48:18.074078Z","steps":["trace[1073462578] 'process raft request'  (duration: 170.846309ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:18.074167Z","caller":"traceutil/trace.go:171","msg":"trace[276594616] transaction","detail":"{read_only:false; response_revision:4688; number_of_response:1; }","duration":"217.218084ms","start":"2026-05-05T09:48:17.856161Z","end":"2026-05-05T09:48:18.073379Z","steps":["trace[276594616] 'process raft request'  (duration: 214.574666ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:18.074561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.851109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"}
{"level":"info","ts":"2026-05-05T09:48:18.074684Z","caller":"traceutil/trace.go:171","msg":"trace[1312462199] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4692; }","duration":"204.009714ms","start":"2026-05-05T09:48:17.870656Z","end":"2026-05-05T09:48:18.074666Z","steps":["trace[1312462199] 'agreement among raft nodes before linearized reading'  (duration: 203.642193ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:18.074928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.875907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:48:18.074967Z","caller":"traceutil/trace.go:171","msg":"trace[699573746] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4692; }","duration":"178.004441ms","start":"2026-05-05T09:48:17.896951Z","end":"2026-05-05T09:48:18.074955Z","steps":["trace[699573746] 'agreement among raft nodes before linearized reading'  (duration: 177.943669ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:18.075565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.516642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e528fd3-d6b1-4707-8b89-2a13ab036429\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-05-05T09:48:18.075601Z","caller":"traceutil/trace.go:171","msg":"trace[123297059] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5e528fd3-d6b1-4707-8b89-2a13ab036429; range_end:; response_count:1; response_revision:4692; }","duration":"133.583713ms","start":"2026-05-05T09:48:17.942009Z","end":"2026-05-05T09:48:18.075593Z","steps":["trace[123297059] 'agreement among raft nodes before linearized reading'  (duration: 133.391717ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:19.477021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.898893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"warn","ts":"2026-05-05T09:48:19.477052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.669655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5e528fd3-d6b1-4707-8b89-2a13ab036429\" ","response":"range_response_count:1 size:3646"}
{"level":"info","ts":"2026-05-05T09:48:19.477096Z","caller":"traceutil/trace.go:171","msg":"trace[149357563] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:4711; }","duration":"328.033037ms","start":"2026-05-05T09:48:19.149045Z","end":"2026-05-05T09:48:19.477078Z","steps":["trace[149357563] 'count revisions from in-memory index tree'  (duration: 327.816731ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:19.477134Z","caller":"traceutil/trace.go:171","msg":"trace[2076262508] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5e528fd3-d6b1-4707-8b89-2a13ab036429; range_end:; response_count:1; response_revision:4711; }","duration":"238.792868ms","start":"2026-05-05T09:48:19.238323Z","end":"2026-05-05T09:48:19.477116Z","steps":["trace[2076262508] 'range keys from in-memory index tree'  (duration: 238.49611ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:19.477142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:19.149025Z","time spent":"328.10526ms","remote":"127.0.0.1:33508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":78,"response size":31,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "}
{"level":"warn","ts":"2026-05-05T09:48:20.519531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.584418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-05-05T09:48:20.519608Z","caller":"traceutil/trace.go:171","msg":"trace[1889047292] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4717; }","duration":"190.726833ms","start":"2026-05-05T09:48:20.328865Z","end":"2026-05-05T09:48:20.519592Z","steps":["trace[1889047292] 'range keys from in-memory index tree'  (duration: 190.29757ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.704397Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":854731715663616524,"retry-timeout":"500ms"}
{"level":"info","ts":"2026-05-05T09:48:30.72213Z","caller":"traceutil/trace.go:171","msg":"trace[281038732] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"569.775019ms","start":"2026-05-05T09:48:30.152323Z","end":"2026-05-05T09:48:30.722098Z","steps":["trace[281038732] 'process raft request'  (duration: 569.569723ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.722379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.152295Z","time spent":"569.988316ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/08db1feb.percona.com\" mod_revision:4841 > success:<request_put:<key:\"/registry/leases/openstack/08db1feb.percona.com\" value_size:453 >> failure:<request_range:<key:\"/registry/leases/openstack/08db1feb.percona.com\" > >"}
{"level":"info","ts":"2026-05-05T09:48:30.843021Z","caller":"traceutil/trace.go:171","msg":"trace[260288519] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"592.558777ms","start":"2026-05-05T09:48:30.25043Z","end":"2026-05-05T09:48:30.842989Z","steps":["trace[260288519] 'process raft request'  (duration: 504.058793ms)","trace[260288519] 'compare'  (duration: 88.275187ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:48:30.843185Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.250406Z","time spent":"592.698221ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare:<target:MOD key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" mod_revision:4845 > success:<request_put:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" value_size:476 >> failure:<request_range:<key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" > >"}
{"level":"info","ts":"2026-05-05T09:48:30.843205Z","caller":"traceutil/trace.go:171","msg":"trace[178898960] linearizableReadLoop","detail":"{readStateIndex:5035; appliedIndex:5032; }","duration":"639.742691ms","start":"2026-05-05T09:48:30.203424Z","end":"2026-05-05T09:48:30.843166Z","steps":["trace[178898960] 'read index received'  (duration: 518.476323ms)","trace[178898960] 'applied index is now lower than readState.Index'  (duration: 121.263588ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:30.843324Z","caller":"traceutil/trace.go:171","msg":"trace[477636799] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"276.28764ms","start":"2026-05-05T09:48:30.567026Z","end":"2026-05-05T09:48:30.843314Z","steps":["trace[477636799] 'process raft request'  (duration: 275.912729ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.84352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.545108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"}
{"level":"info","ts":"2026-05-05T09:48:30.843559Z","caller":"traceutil/trace.go:171","msg":"trace[1551976872] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4855; }","duration":"114.63074ms","start":"2026-05-05T09:48:30.728918Z","end":"2026-05-05T09:48:30.843549Z","steps":["trace[1551976872] 'agreement among raft nodes before linearized reading'  (duration: 114.485346ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.843614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.760331ms","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":"warn","ts":"2026-05-05T09:48:30.843619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.359924ms","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-05-05T09:48:30.843695Z","caller":"traceutil/trace.go:171","msg":"trace[573036524] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4855; }","duration":"271.461677ms","start":"2026-05-05T09:48:30.572217Z","end":"2026-05-05T09:48:30.843678Z","steps":["trace[573036524] 'agreement among raft nodes before linearized reading'  (duration: 271.250071ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:30.843684Z","caller":"traceutil/trace.go:171","msg":"trace[219134447] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4855; }","duration":"633.853635ms","start":"2026-05-05T09:48:30.209813Z","end":"2026-05-05T09:48:30.843667Z","steps":["trace[219134447] 'agreement among raft nodes before linearized reading'  (duration: 633.551506ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.843618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.236868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusrules/\" range_end:\"/registry/monitoring.coreos.com/prometheusrules0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T09:48:30.843907Z","caller":"traceutil/trace.go:171","msg":"trace[27588990] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusrules/; range_end:/registry/monitoring.coreos.com/prometheusrules0; response_count:0; response_revision:4855; }","duration":"280.66604ms","start":"2026-05-05T09:48:30.563219Z","end":"2026-05-05T09:48:30.843885Z","steps":["trace[27588990] 'agreement among raft nodes before linearized reading'  (duration: 280.201396ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.843914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.533458ms","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-05-05T09:48:30.84406Z","caller":"traceutil/trace.go:171","msg":"trace[7025361] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4855; }","duration":"272.771505ms","start":"2026-05-05T09:48:30.57127Z","end":"2026-05-05T09:48:30.844041Z","steps":["trace[7025361] 'agreement among raft nodes before linearized reading'  (duration: 272.427894ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.844124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.083316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2026-05-05T09:48:30.843976Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.455582ms","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-05-05T09:48:30.844346Z","caller":"traceutil/trace.go:171","msg":"trace[529545309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4855; }","duration":"640.900355ms","start":"2026-05-05T09:48:30.203387Z","end":"2026-05-05T09:48:30.844288Z","steps":["trace[529545309] 'agreement among raft nodes before linearized reading'  (duration: 640.022199ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.844395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.561753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"}
{"level":"warn","ts":"2026-05-05T09:48:30.843904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.209802Z","time spent":"634.082571ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "}
{"level":"info","ts":"2026-05-05T09:48:30.844584Z","caller":"traceutil/trace.go:171","msg":"trace[1232459848] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4855; }","duration":"486.78748ms","start":"2026-05-05T09:48:30.357778Z","end":"2026-05-05T09:48:30.844566Z","steps":["trace[1232459848] 'agreement among raft nodes before linearized reading'  (duration: 486.315916ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:30.844164Z","caller":"traceutil/trace.go:171","msg":"trace[712681865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4855; }","duration":"308.154248ms","start":"2026-05-05T09:48:30.536Z","end":"2026-05-05T09:48:30.844154Z","steps":["trace[712681865] 'agreement among raft nodes before linearized reading'  (duration: 308.106196ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.844697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.535977Z","time spent":"308.706034ms","remote":"127.0.0.1:33418","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-05-05T09:48:30.844789Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.357754Z","time spent":"486.870752ms","remote":"127.0.0.1:33604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10416,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "}
{"level":"warn","ts":"2026-05-05T09:48:30.84408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.866084ms","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":"warn","ts":"2026-05-05T09:48:30.844742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"633.6778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"}
{"level":"info","ts":"2026-05-05T09:48:30.844908Z","caller":"traceutil/trace.go:171","msg":"trace[341649171] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4855; }","duration":"442.75804ms","start":"2026-05-05T09:48:30.402118Z","end":"2026-05-05T09:48:30.844876Z","steps":["trace[341649171] 'agreement among raft nodes before linearized reading'  (duration: 441.883934ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.844949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.402102Z","time spent":"442.834733ms","remote":"127.0.0.1:33572","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-05-05T09:48:30.844422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.203371Z","time spent":"641.031979ms","remote":"127.0.0.1:33662","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":"info","ts":"2026-05-05T09:48:30.84496Z","caller":"traceutil/trace.go:171","msg":"trace[559942023] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4855; }","duration":"633.968208ms","start":"2026-05-05T09:48:30.210965Z","end":"2026-05-05T09:48:30.844934Z","steps":["trace[559942023] 'agreement among raft nodes before linearized reading'  (duration: 633.569256ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.845749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T09:48:30.210954Z","time spent":"634.772032ms","remote":"127.0.0.1:33662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}
{"level":"info","ts":"2026-05-05T09:48:30.976154Z","caller":"traceutil/trace.go:171","msg":"trace[1347783727] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"125.547514ms","start":"2026-05-05T09:48:30.850582Z","end":"2026-05-05T09:48:30.976129Z","steps":["trace[1347783727] 'process raft request'  (duration: 125.371739ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:30.976493Z","caller":"traceutil/trace.go:171","msg":"trace[1853175587] transaction","detail":"{read_only:false; response_revision:4858; number_of_response:1; }","duration":"125.759981ms","start":"2026-05-05T09:48:30.850691Z","end":"2026-05-05T09:48:30.976451Z","steps":["trace[1853175587] 'process raft request'  (duration: 125.39678ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:30.976637Z","caller":"traceutil/trace.go:171","msg":"trace[2073994181] transaction","detail":"{read_only:false; response_revision:4859; number_of_response:1; }","duration":"125.863974ms","start":"2026-05-05T09:48:30.850736Z","end":"2026-05-05T09:48:30.9766Z","steps":["trace[2073994181] 'process raft request'  (duration: 125.660328ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:30.976821Z","caller":"traceutil/trace.go:171","msg":"trace[1866555382] transaction","detail":"{read_only:false; response_revision:4860; number_of_response:1; }","duration":"125.783282ms","start":"2026-05-05T09:48:30.851025Z","end":"2026-05-05T09:48:30.976808Z","steps":["trace[1866555382] 'process raft request'  (duration: 125.508023ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:30.977067Z","caller":"traceutil/trace.go:171","msg":"trace[1165791549] linearizableReadLoop","detail":"{readStateIndex:5040; appliedIndex:5036; }","duration":"123.911567ms","start":"2026-05-05T09:48:30.85294Z","end":"2026-05-05T09:48:30.976852Z","steps":["trace[1165791549] 'read index received'  (duration: 76.854437ms)","trace[1165791549] 'applied index is now lower than readState.Index'  (duration: 47.05648ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:30.977145Z","caller":"traceutil/trace.go:171","msg":"trace[890654801] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"121.193086ms","start":"2026-05-05T09:48:30.855945Z","end":"2026-05-05T09:48:30.977138Z","steps":["trace[890654801] 'process raft request'  (duration: 120.726062ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:48:30.9773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.35348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"}
{"level":"info","ts":"2026-05-05T09:48:30.977347Z","caller":"traceutil/trace.go:171","msg":"trace[712219730] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4861; }","duration":"124.424743ms","start":"2026-05-05T09:48:30.852911Z","end":"2026-05-05T09:48:30.977335Z","steps":["trace[712219730] 'agreement among raft nodes before linearized reading'  (duration: 124.295529ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:48:31.54266Z","caller":"traceutil/trace.go:171","msg":"trace[1944165899] transaction","detail":"{read_only:false; response_revision:4878; number_of_response:1; }","duration":"103.463668ms","start":"2026-05-05T09:48:31.439173Z","end":"2026-05-05T09:48:31.542637Z","steps":["trace[1944165899] 'process raft request'  (duration: 24.862509ms)","trace[1944165899] 'compare'  (duration: 78.390122ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:56.421874Z","caller":"traceutil/trace.go:171","msg":"trace[598674098] linearizableReadLoop","detail":"{readStateIndex:5212; appliedIndex:5211; }","duration":"110.518554ms","start":"2026-05-05T09:48:56.311329Z","end":"2026-05-05T09:48:56.421847Z","steps":["trace[598674098] 'read index received'  (duration: 75.759644ms)","trace[598674098] 'applied index is now lower than readState.Index'  (duration: 34.75783ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:48:56.421994Z","caller":"traceutil/trace.go:171","msg":"trace[654798824] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"111.669398ms","start":"2026-05-05T09:48:56.310313Z","end":"2026-05-05T09:48:56.421982Z","steps":["trace[654798824] 'process raft request'  (duration: 76.886307ms)","trace[654798824] 'compare'  (duration: 34.464711ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:48:56.422164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.820713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/monitoring/\" range_end:\"/registry/resourcequotas/monitoring0\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:48:56.422222Z","caller":"traceutil/trace.go:171","msg":"trace[874678835] range","detail":"{range_begin:/registry/resourcequotas/monitoring/; range_end:/registry/resourcequotas/monitoring0; response_count:0; response_revision:5026; }","duration":"110.880845ms","start":"2026-05-05T09:48:56.311307Z","end":"2026-05-05T09:48:56.422188Z","steps":["trace[874678835] 'agreement among raft nodes before linearized reading'  (duration: 110.796523ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:49:09.101867Z","caller":"traceutil/trace.go:171","msg":"trace[977581984] transaction","detail":"{read_only:false; response_revision:5187; number_of_response:1; }","duration":"105.756278ms","start":"2026-05-05T09:49:08.996076Z","end":"2026-05-05T09:49:09.101833Z","steps":["trace[977581984] 'process raft request'  (duration: 25.319858ms)","trace[977581984] 'compare'  (duration: 80.271235ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:49:13.639396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.514721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-credential-setup\" ","response":"range_response_count:1 size:6159"}
{"level":"info","ts":"2026-05-05T09:49:13.639478Z","caller":"traceutil/trace.go:171","msg":"trace[1080085483] range","detail":"{range_begin:/registry/jobs/openstack/keystone-credential-setup; range_end:; response_count:1; response_revision:5219; }","duration":"184.654475ms","start":"2026-05-05T09:49:13.454807Z","end":"2026-05-05T09:49:13.639461Z","steps":["trace[1080085483] 'range keys from in-memory index tree'  (duration: 184.297784ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:49:13.639481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.515801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:49:13.639618Z","caller":"traceutil/trace.go:171","msg":"trace[104862779] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:0; response_revision:5219; }","duration":"186.663805ms","start":"2026-05-05T09:49:13.452887Z","end":"2026-05-05T09:49:13.639551Z","steps":["trace[104862779] 'range keys from in-memory index tree'  (duration: 186.361386ms)"],"step_count":1}
{"level":"warn","ts":"2026-05-05T09:49:13.63984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.80872ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2026-05-05T09:49:13.639894Z","caller":"traceutil/trace.go:171","msg":"trace[561947621] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:0; response_revision:5219; }","duration":"186.881572ms","start":"2026-05-05T09:49:13.452999Z","end":"2026-05-05T09:49:13.639881Z","steps":["trace[561947621] 'range keys from in-memory index tree'  (duration: 186.223322ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:49:13.798976Z","caller":"traceutil/trace.go:171","msg":"trace[678127393] linearizableReadLoop","detail":"{readStateIndex:5411; appliedIndex:5410; }","duration":"116.515183ms","start":"2026-05-05T09:49:13.682434Z","end":"2026-05-05T09:49:13.79895Z","steps":["trace[678127393] 'read index received'  (duration: 84.981757ms)","trace[678127393] 'applied index is now lower than readState.Index'  (duration: 31.532406ms)"],"step_count":2}
{"level":"warn","ts":"2026-05-05T09:49:13.79913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.671238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2026-05-05T09:49:13.799167Z","caller":"traceutil/trace.go:171","msg":"trace[1991649480] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:5221; }","duration":"116.75728ms","start":"2026-05-05T09:49:13.682396Z","end":"2026-05-05T09:49:13.799153Z","steps":["trace[1991649480] 'agreement among raft nodes before linearized reading'  (duration: 116.667118ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:49:13.799397Z","caller":"traceutil/trace.go:171","msg":"trace[456622126] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"168.427968ms","start":"2026-05-05T09:49:13.630927Z","end":"2026-05-05T09:49:13.799355Z","steps":["trace[456622126] 'process raft request'  (duration: 136.608534ms)","trace[456622126] 'compare'  (duration: 31.04903ms)"],"step_count":2}
{"level":"info","ts":"2026-05-05T09:49:17.575527Z","caller":"traceutil/trace.go:171","msg":"trace[1147221089] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"106.414581ms","start":"2026-05-05T09:49:17.469091Z","end":"2026-05-05T09:49:17.575505Z","steps":["trace[1147221089] 'process raft request'  (duration: 106.334539ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:49:17.57555Z","caller":"traceutil/trace.go:171","msg":"trace[604534242] transaction","detail":"{read_only:false; response_revision:5254; number_of_response:1; }","duration":"108.236216ms","start":"2026-05-05T09:49:17.467295Z","end":"2026-05-05T09:49:17.575531Z","steps":["trace[604534242] 'process raft request'  (duration: 104.38883ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:49:17.575771Z","caller":"traceutil/trace.go:171","msg":"trace[243273523] transaction","detail":"{read_only:false; response_revision:5256; number_of_response:1; }","duration":"105.459363ms","start":"2026-05-05T09:49:17.470298Z","end":"2026-05-05T09:49:17.575758Z","steps":["trace[243273523] 'process raft request'  (duration: 105.165104ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:49:17.575808Z","caller":"traceutil/trace.go:171","msg":"trace[2064437381] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"104.976689ms","start":"2026-05-05T09:49:17.470807Z","end":"2026-05-05T09:49:17.575784Z","steps":["trace[2064437381] 'process raft request'  (duration: 104.820784ms)"],"step_count":1}
{"level":"info","ts":"2026-05-05T09:50:11.427526Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2926}
{"level":"info","ts":"2026-05-05T09:50:11.529156Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2926,"took":"99.992548ms","hash":1373762268,"current-db-size-bytes":53948416,"current-db-size":"54 MB","current-db-size-in-use-bytes":29503488,"current-db-size-in-use":"30 MB"}
{"level":"info","ts":"2026-05-05T09:50:11.529255Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1373762268,"revision":2926,"compact-revision":-1}
{"level":"info","ts":"2026-05-05T09:55:11.434387Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5643}
{"level":"info","ts":"2026-05-05T09:55:11.513044Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5643,"took":"77.202862ms","hash":1149318367,"current-db-size-bytes":53948416,"current-db-size":"54 MB","current-db-size-in-use-bytes":18325504,"current-db-size-in-use":"18 MB"}
{"level":"info","ts":"2026-05-05T09:55:11.513106Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1149318367,"revision":5643,"compact-revision":2926}