{"level":"warn","ts":"2026-08-26T00:18:26.137028Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-26T00:18:26.13712Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.80: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://162.253.55.80:2380","--initial-cluster=instance=https://162.253.55.80:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.80:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.80: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-08-26T00:18:26.137198Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-26T00:18:26.137212Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-08-26T00:18:26.137229Z","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-08-26T00:18:26.137861Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"]} {"level":"info","ts":"2026-08-26T00:18:26.137934Z","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://162.253.55.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.80: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-08-26T00:18:26.142557Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.423366ms"} {"level":"info","ts":"2026-08-26T00:18:26.154545Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a87e3d9cf178847b","cluster-id":"df2e96c7e71d56b9"} {"level":"info","ts":"2026-08-26T00:18:26.154639Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=()"} {"level":"info","ts":"2026-08-26T00:18:26.154661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 0"} {"level":"info","ts":"2026-08-26T00:18:26.154671Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a87e3d9cf178847b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-26T00:18:26.154683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became follower at term 1"} {"level":"info","ts":"2026-08-26T00:18:26.154718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"warn","ts":"2026-08-26T00:18:26.165826Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-26T00:18:26.172414Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-26T00:18:26.173888Z","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-08-26T00:18:26.176056Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a87e3d9cf178847b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-26T00:18:26.176576Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a87e3d9cf178847b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-26T00:18:26.176522Z","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-08-26T00:18:26.17708Z","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-08-26T00:18:26.177147Z","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-08-26T00:18:26.179277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b switched to configuration voters=(12141209389712835707)"} {"level":"info","ts":"2026-08-26T00:18:26.179408Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","added-peer-id":"a87e3d9cf178847b","added-peer-peer-urls":["https://162.253.55.80:2380"]} {"level":"info","ts":"2026-08-26T00:18:26.181115Z","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-08-26T00:18:26.181232Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-08-26T00:18:26.181268Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.80:2380"} {"level":"info","ts":"2026-08-26T00:18:26.182715Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a87e3d9cf178847b","initial-advertise-peer-urls":["https://162.253.55.80:2380"],"listen-peer-urls":["https://162.253.55.80:2380"],"advertise-client-urls":["https://162.253.55.80:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.80:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-26T00:18:26.182756Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-26T00:18:26.755446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b is starting a new election at term 1"} {"level":"info","ts":"2026-08-26T00:18:26.755501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-26T00:18:26.755662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgPreVoteResp from a87e3d9cf178847b at term 1"} {"level":"info","ts":"2026-08-26T00:18:26.755694Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became candidate at term 2"} {"level":"info","ts":"2026-08-26T00:18:26.755817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b received MsgVoteResp from a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-08-26T00:18:26.755942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a87e3d9cf178847b became leader at term 2"} {"level":"info","ts":"2026-08-26T00:18:26.755968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a87e3d9cf178847b elected leader a87e3d9cf178847b at term 2"} {"level":"info","ts":"2026-08-26T00:18:26.757017Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T00:18:26.758034Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T00:18:26.758035Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a87e3d9cf178847b","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.80:2379]}","request-path":"/0/members/a87e3d9cf178847b/attributes","cluster-id":"df2e96c7e71d56b9","publish-timeout":"7s"} {"level":"info","ts":"2026-08-26T00:18:26.758389Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T00:18:26.75857Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-26T00:18:26.758622Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"df2e96c7e71d56b9","local-member-id":"a87e3d9cf178847b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T00:18:26.758666Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-26T00:18:26.758826Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T00:18:26.75887Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T00:18:26.760101Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.80:2379"} {"level":"info","ts":"2026-08-26T00:18:26.761202Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-26T00:18:44.655763Z","caller":"traceutil/trace.go:171","msg":"trace[1142172901] linearizableReadLoop","detail":"{readStateIndex:425; appliedIndex:424; }","duration":"100.009117ms","start":"2026-08-26T00:18:44.555729Z","end":"2026-08-26T00:18:44.655738Z","steps":["trace[1142172901] 'read index received' (duration: 99.855553ms)","trace[1142172901] 'applied index is now lower than readState.Index' (duration: 152.584µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:18:44.655821Z","caller":"traceutil/trace.go:171","msg":"trace[432122258] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"111.401974ms","start":"2026-08-26T00:18:44.544382Z","end":"2026-08-26T00:18:44.655784Z","steps":["trace[432122258] 'process raft request' (duration: 111.220218ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:18:44.656041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.283235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-26T00:18:44.656133Z","caller":"traceutil/trace.go:171","msg":"trace[1224045467] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:413; }","duration":"100.439641ms","start":"2026-08-26T00:18:44.555674Z","end":"2026-08-26T00:18:44.656114Z","steps":["trace[1224045467] 'agreement among raft nodes before linearized reading' (duration: 100.189473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:18:44.944719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.509724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T00:18:44.944796Z","caller":"traceutil/trace.go:171","msg":"trace[1860907392] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"284.779587ms","start":"2026-08-26T00:18:44.660006Z","end":"2026-08-26T00:18:44.944786Z","steps":["trace[1860907392] 'process raft request' (duration: 40.80101ms)","trace[1860907392] 'compare' (duration: 243.376539ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T00:19:09.248461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.545209ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T00:19:09.248566Z","caller":"traceutil/trace.go:171","msg":"trace[326233010] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:655; }","duration":"191.254647ms","start":"2026-08-26T00:19:09.057294Z","end":"2026-08-26T00:19:09.248549Z","steps":["trace[326233010] 'read index received' (duration: 72.542494ms)","trace[326233010] 'applied index is now lower than readState.Index' (duration: 118.711083ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T00:19:09.248695Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.40666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-26T00:19:09.248727Z","caller":"traceutil/trace.go:171","msg":"trace[90581303] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"191.473772ms","start":"2026-08-26T00:19:09.057244Z","end":"2026-08-26T00:19:09.248718Z","steps":["trace[90581303] 'agreement among raft nodes before linearized reading' (duration: 191.350219ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:19:09.249429Z","caller":"traceutil/trace.go:171","msg":"trace[1314863640] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"217.005179ms","start":"2026-08-26T00:19:09.032321Z","end":"2026-08-26T00:19:09.249327Z","steps":["trace[1314863640] 'process raft request' (duration: 97.491748ms)","trace[1314863640] 'compare' (duration: 118.444986ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:19:51.082982Z","caller":"traceutil/trace.go:171","msg":"trace[610141897] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"108.388507ms","start":"2026-08-26T00:19:50.974572Z","end":"2026-08-26T00:19:51.082961Z","steps":["trace[610141897] 'process raft request' (duration: 108.01474ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.466966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.634813ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T00:20:37.467082Z","caller":"traceutil/trace.go:171","msg":"trace[217679758] transaction","detail":"{read_only:false; response_revision:1858; number_of_response:1; }","duration":"431.078286ms","start":"2026-08-26T00:20:37.035984Z","end":"2026-08-26T00:20:37.467062Z","steps":["trace[217679758] 'process raft request' (duration: 288.280042ms)","trace[217679758] 'compare' (duration: 142.48927ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T00:20:37.46715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:20:37.035964Z","time spent":"431.155299ms","remote":"127.0.0.1:55020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":976,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T00:20:37.504596Z","caller":"traceutil/trace.go:171","msg":"trace[858202122] transaction","detail":"{read_only:false; response_revision:1859; number_of_response:1; }","duration":"468.409981ms","start":"2026-08-26T00:20:37.036168Z","end":"2026-08-26T00:20:37.504578Z","steps":["trace[858202122] 'process raft request' (duration: 468.281999ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.504686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:20:37.036158Z","time spent":"468.485122ms","remote":"127.0.0.1:55020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T00:20:37.504885Z","caller":"traceutil/trace.go:171","msg":"trace[527149194] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"468.516352ms","start":"2026-08-26T00:20:37.036344Z","end":"2026-08-26T00:20:37.504861Z","steps":["trace[527149194] 'process raft request' (duration: 468.193138ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:20:37.504986Z","caller":"traceutil/trace.go:171","msg":"trace[1777363822] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1925; }","duration":"390.974123ms","start":"2026-08-26T00:20:37.113991Z","end":"2026-08-26T00:20:37.504965Z","steps":["trace[1777363822] 'read index received' (duration: 210.286836ms)","trace[1777363822] 'applied index is now lower than readState.Index' (duration: 180.686317ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T00:20:37.505055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:20:37.036336Z","time spent":"468.613744ms","remote":"127.0.0.1:55108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1470,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T00:20:37.505093Z","caller":"traceutil/trace.go:171","msg":"trace[7284583] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"462.876337ms","start":"2026-08-26T00:20:37.042198Z","end":"2026-08-26T00:20:37.505074Z","steps":["trace[7284583] 'process raft request' (duration: 462.658063ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.505172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:20:37.042178Z","time spent":"462.955028ms","remote":"127.0.0.1:55028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T00:20:37.505353Z","caller":"traceutil/trace.go:171","msg":"trace[841911282] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"468.812907ms","start":"2026-08-26T00:20:37.036529Z","end":"2026-08-26T00:20:37.505341Z","steps":["trace[841911282] 'process raft request' (duration: 468.164877ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.505412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:20:37.036523Z","time spent":"468.858947ms","remote":"127.0.0.1:55108","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1528,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T00:20:37.50544Z","caller":"traceutil/trace.go:171","msg":"trace[530520777] transaction","detail":"{read_only:false; response_revision:1863; number_of_response:1; }","duration":"263.868763ms","start":"2026-08-26T00:20:37.241517Z","end":"2026-08-26T00:20:37.505386Z","steps":["trace[530520777] 'process raft request' (duration: 263.393126ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.50534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.302358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-97aca5ac-269e-4c42-9430-a9a02ec1e520\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-08-26T00:20:37.505557Z","caller":"traceutil/trace.go:171","msg":"trace[680817685] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-97aca5ac-269e-4c42-9430-a9a02ec1e520; range_end:; response_count:1; response_revision:1863; }","duration":"391.598692ms","start":"2026-08-26T00:20:37.113946Z","end":"2026-08-26T00:20:37.505545Z","steps":["trace[680817685] 'agreement among raft nodes before linearized reading' (duration: 391.257647ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.505593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:20:37.113924Z","time spent":"391.661213ms","remote":"127.0.0.1:55028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3770,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-97aca5ac-269e-4c42-9430-a9a02ec1e520\" "} {"level":"warn","ts":"2026-08-26T00:20:37.50563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.720014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T00:20:37.506121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.253351ms","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-08-26T00:20:37.506239Z","caller":"traceutil/trace.go:171","msg":"trace[500130066] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1863; }","duration":"174.415253ms","start":"2026-08-26T00:20:37.331803Z","end":"2026-08-26T00:20:37.506218Z","steps":["trace[500130066] 'agreement among raft nodes before linearized reading' (duration: 174.180209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.506309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.743316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-26T00:20:37.506349Z","caller":"traceutil/trace.go:171","msg":"trace[1552382013] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1863; }","duration":"146.806537ms","start":"2026-08-26T00:20:37.359532Z","end":"2026-08-26T00:20:37.506339Z","steps":["trace[1552382013] 'agreement among raft nodes before linearized reading' (duration: 146.283229ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:20:37.507Z","caller":"traceutil/trace.go:171","msg":"trace[2067514400] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:1863; }","duration":"236.836045ms","start":"2026-08-26T00:20:37.268861Z","end":"2026-08-26T00:20:37.505697Z","steps":["trace[2067514400] 'agreement among raft nodes before linearized reading' (duration: 236.673202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.824623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.250697ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T00:20:37.824771Z","caller":"traceutil/trace.go:171","msg":"trace[348300268] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1864; }","duration":"199.43456ms","start":"2026-08-26T00:20:37.625316Z","end":"2026-08-26T00:20:37.824751Z","steps":["trace[348300268] 'range keys from in-memory index tree' (duration: 199.231737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.824851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.224708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-26T00:20:37.824972Z","caller":"traceutil/trace.go:171","msg":"trace[269624025] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1864; }","duration":"164.388921ms","start":"2026-08-26T00:20:37.660543Z","end":"2026-08-26T00:20:37.824932Z","steps":["trace[269624025] 'range keys from in-memory index tree' (duration: 164.029755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:20:37.82493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.881377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T00:20:37.82504Z","caller":"traceutil/trace.go:171","msg":"trace[146308683] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1864; }","duration":"241.023908ms","start":"2026-08-26T00:20:37.583997Z","end":"2026-08-26T00:20:37.825021Z","steps":["trace[146308683] 'range keys from in-memory index tree' (duration: 240.817565ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:20:37.825721Z","caller":"traceutil/trace.go:171","msg":"trace[2097037421] transaction","detail":"{read_only:false; response_revision:1865; number_of_response:1; }","duration":"153.645919ms","start":"2026-08-26T00:20:37.672041Z","end":"2026-08-26T00:20:37.825687Z","steps":["trace[2097037421] 'process raft request' (duration: 96.350233ms)","trace[2097037421] 'compare' (duration: 56.347601ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:20:49.197717Z","caller":"traceutil/trace.go:171","msg":"trace[52406209] transaction","detail":"{read_only:false; response_revision:1961; number_of_response:1; }","duration":"106.961944ms","start":"2026-08-26T00:20:49.090728Z","end":"2026-08-26T00:20:49.19769Z","steps":["trace[52406209] 'process raft request' (duration: 106.797591ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:21:12.189293Z","caller":"traceutil/trace.go:171","msg":"trace[297373171] linearizableReadLoop","detail":"{readStateIndex:2180; appliedIndex:2179; }","duration":"141.594161ms","start":"2026-08-26T00:21:12.04767Z","end":"2026-08-26T00:21:12.189264Z","steps":["trace[297373171] 'read index received' (duration: 134.799887ms)","trace[297373171] 'applied index is now lower than readState.Index' (duration: 6.792854ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:21:12.189326Z","caller":"traceutil/trace.go:171","msg":"trace[1856516505] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"157.276041ms","start":"2026-08-26T00:21:12.032019Z","end":"2026-08-26T00:21:12.189295Z","steps":["trace[1856516505] 'process raft request' (duration: 150.509627ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:21:12.189662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.906585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-08-26T00:21:12.189757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.928175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-26T00:21:12.189796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.416759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-26T00:21:12.189774Z","caller":"traceutil/trace.go:171","msg":"trace[1461954098] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2104; }","duration":"142.127639ms","start":"2026-08-26T00:21:12.047621Z","end":"2026-08-26T00:21:12.189749Z","steps":["trace[1461954098] 'agreement among raft nodes before linearized reading' (duration: 141.755574ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:21:12.189873Z","caller":"traceutil/trace.go:171","msg":"trace[1064648561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2104; }","duration":"139.114798ms","start":"2026-08-26T00:21:12.05073Z","end":"2026-08-26T00:21:12.189845Z","steps":["trace[1064648561] 'agreement among raft nodes before linearized reading' (duration: 138.710432ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:21:12.189902Z","caller":"traceutil/trace.go:171","msg":"trace[1267346391] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2104; }","duration":"131.564553ms","start":"2026-08-26T00:21:12.058305Z","end":"2026-08-26T00:21:12.189869Z","steps":["trace[1267346391] 'agreement among raft nodes before linearized reading' (duration: 131.308688ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:21:12.558671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.103363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T00:21:12.559097Z","caller":"traceutil/trace.go:171","msg":"trace[1656242768] transaction","detail":"{read_only:false; response_revision:2107; number_of_response:1; }","duration":"153.984644ms","start":"2026-08-26T00:21:12.405063Z","end":"2026-08-26T00:21:12.559048Z","steps":["trace[1656242768] 'process raft request' (duration: 15.423095ms)","trace[1656242768] 'compare' (duration: 138.014472ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T00:22:16.113941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.758205ms","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-08-26T00:22:16.114053Z","caller":"traceutil/trace.go:171","msg":"trace[2084398309] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2549; }","duration":"125.896746ms","start":"2026-08-26T00:22:15.988117Z","end":"2026-08-26T00:22:16.114014Z","steps":["trace[2084398309] 'range keys from in-memory index tree' (duration: 125.597522ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:26:42.163961Z","caller":"traceutil/trace.go:171","msg":"trace[248724588] linearizableReadLoop","detail":"{readStateIndex:4816; appliedIndex:4815; }","duration":"148.103284ms","start":"2026-08-26T00:26:42.015833Z","end":"2026-08-26T00:26:42.163937Z","steps":["trace[248724588] 'read index received' (duration: 147.912121ms)","trace[248724588] 'applied index is now lower than readState.Index' (duration: 190.013µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:26:42.164107Z","caller":"traceutil/trace.go:171","msg":"trace[1813104087] transaction","detail":"{read_only:false; response_revision:4639; number_of_response:1; }","duration":"151.722794ms","start":"2026-08-26T00:26:42.012347Z","end":"2026-08-26T00:26:42.16407Z","steps":["trace[1813104087] 'process raft request' (duration: 151.409629ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:42.164245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.395189ms","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-08-26T00:26:42.164313Z","caller":"traceutil/trace.go:171","msg":"trace[709636604] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4639; }","duration":"148.530241ms","start":"2026-08-26T00:26:42.015764Z","end":"2026-08-26T00:26:42.164294Z","steps":["trace[709636604] 'agreement among raft nodes before linearized reading' (duration: 148.304217ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:42.164326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.213226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-26T00:26:42.164412Z","caller":"traceutil/trace.go:171","msg":"trace[551729471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4639; }","duration":"120.331018ms","start":"2026-08-26T00:26:42.044062Z","end":"2026-08-26T00:26:42.164393Z","steps":["trace[551729471] 'agreement among raft nodes before linearized reading' (duration: 120.074434ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:26:48.021699Z","caller":"traceutil/trace.go:171","msg":"trace[1970804347] linearizableReadLoop","detail":"{readStateIndex:4886; appliedIndex:4885; }","duration":"219.398758ms","start":"2026-08-26T00:26:47.802272Z","end":"2026-08-26T00:26:48.02167Z","steps":["trace[1970804347] 'read index received' (duration: 219.117263ms)","trace[1970804347] 'applied index is now lower than readState.Index' (duration: 280.205µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:26:48.021799Z","caller":"traceutil/trace.go:171","msg":"trace[476883780] transaction","detail":"{read_only:false; response_revision:4708; number_of_response:1; }","duration":"227.931821ms","start":"2026-08-26T00:26:47.793802Z","end":"2026-08-26T00:26:48.021734Z","steps":["trace[476883780] 'process raft request' (duration: 227.630716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:48.022121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.818465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12973"} {"level":"info","ts":"2026-08-26T00:26:48.022174Z","caller":"traceutil/trace.go:171","msg":"trace[618668769] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4708; }","duration":"219.912957ms","start":"2026-08-26T00:26:47.802245Z","end":"2026-08-26T00:26:48.022158Z","steps":["trace[618668769] 'agreement among raft nodes before linearized reading' (duration: 219.561951ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:26:48.035804Z","caller":"traceutil/trace.go:171","msg":"trace[2046409661] transaction","detail":"{read_only:false; response_revision:4709; number_of_response:1; }","duration":"133.848612ms","start":"2026-08-26T00:26:47.90194Z","end":"2026-08-26T00:26:48.035788Z","steps":["trace[2046409661] 'process raft request' (duration: 133.767601ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:48.036176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.814669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-596fdf448d-djbs6.18cf33529032f407\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-08-26T00:26:48.036449Z","caller":"traceutil/trace.go:171","msg":"trace[342160987] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-596fdf448d-djbs6.18cf33529032f407; range_end:; response_count:1; response_revision:4709; }","duration":"233.942411ms","start":"2026-08-26T00:26:47.802307Z","end":"2026-08-26T00:26:48.03625Z","steps":["trace[342160987] 'agreement among raft nodes before linearized reading' (duration: 233.540834ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:48.037775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.781088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-08-26T00:26:48.037808Z","caller":"traceutil/trace.go:171","msg":"trace[1905500022] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4709; }","duration":"161.88478ms","start":"2026-08-26T00:26:47.875914Z","end":"2026-08-26T00:26:48.037799Z","steps":["trace[1905500022] 'agreement among raft nodes before linearized reading' (duration: 160.040839ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:26:48.629074Z","caller":"traceutil/trace.go:171","msg":"trace[51080472] transaction","detail":"{read_only:false; response_revision:4737; number_of_response:1; }","duration":"173.718394ms","start":"2026-08-26T00:26:48.455302Z","end":"2026-08-26T00:26:48.629021Z","steps":["trace[51080472] 'process raft request' (duration: 96.852183ms)","trace[51080472] 'compare' (duration: 76.651217ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:26:48.629204Z","caller":"traceutil/trace.go:171","msg":"trace[1119289032] linearizableReadLoop","detail":"{readStateIndex:4915; appliedIndex:4913; }","duration":"164.995659ms","start":"2026-08-26T00:26:48.464185Z","end":"2026-08-26T00:26:48.629181Z","steps":["trace[1119289032] 'read index received' (duration: 32.904509ms)","trace[1119289032] 'applied index is now lower than readState.Index' (duration: 132.08955ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:26:48.629383Z","caller":"traceutil/trace.go:171","msg":"trace[265778208] transaction","detail":"{read_only:false; response_revision:4738; number_of_response:1; }","duration":"127.937261ms","start":"2026-08-26T00:26:48.501424Z","end":"2026-08-26T00:26:48.629362Z","steps":["trace[265778208] 'process raft request' (duration: 127.561695ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:48.629703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.485097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"info","ts":"2026-08-26T00:26:48.629758Z","caller":"traceutil/trace.go:171","msg":"trace[924028895] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4738; }","duration":"165.561898ms","start":"2026-08-26T00:26:48.464179Z","end":"2026-08-26T00:26:48.629741Z","steps":["trace[924028895] 'agreement among raft nodes before linearized reading' (duration: 165.332735ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:48.630187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.348747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-keystone-server\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T00:26:48.630231Z","caller":"traceutil/trace.go:171","msg":"trace[376840244] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-keystone-server; range_end:; response_count:0; response_revision:4738; }","duration":"128.44104ms","start":"2026-08-26T00:26:48.501779Z","end":"2026-08-26T00:26:48.63022Z","steps":["trace[376840244] 'agreement among raft nodes before linearized reading' (duration: 128.374039ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:26:48.631039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.530128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207411"} {"level":"info","ts":"2026-08-26T00:26:48.631093Z","caller":"traceutil/trace.go:171","msg":"trace[12046959] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4738; }","duration":"144.65135ms","start":"2026-08-26T00:26:48.486428Z","end":"2026-08-26T00:26:48.631079Z","steps":["trace[12046959] 'agreement among raft nodes before linearized reading' (duration: 143.371068ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:27:01.019278Z","caller":"traceutil/trace.go:171","msg":"trace[1028212467] transaction","detail":"{read_only:false; response_revision:4941; number_of_response:1; }","duration":"216.895268ms","start":"2026-08-26T00:27:00.802346Z","end":"2026-08-26T00:27:01.019241Z","steps":["trace[1028212467] 'process raft request' (duration: 216.669744ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:27:01.232156Z","caller":"traceutil/trace.go:171","msg":"trace[1658322507] linearizableReadLoop","detail":"{readStateIndex:5127; appliedIndex:5126; }","duration":"182.801513ms","start":"2026-08-26T00:27:01.049322Z","end":"2026-08-26T00:27:01.232124Z","steps":["trace[1658322507] 'read index received' (duration: 173.693784ms)","trace[1658322507] 'applied index is now lower than readState.Index' (duration: 9.106889ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T00:27:01.232215Z","caller":"traceutil/trace.go:171","msg":"trace[180100117] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"197.620888ms","start":"2026-08-26T00:27:01.034562Z","end":"2026-08-26T00:27:01.232183Z","steps":["trace[180100117] 'process raft request' (duration: 189.700898ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:27:01.232409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.055767ms","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-08-26T00:27:01.23246Z","caller":"traceutil/trace.go:171","msg":"trace[937233783] 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:4943; }","duration":"183.179749ms","start":"2026-08-26T00:27:01.049263Z","end":"2026-08-26T00:27:01.232443Z","steps":["trace[937233783] 'agreement among raft nodes before linearized reading' (duration: 183.000006ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:27:01.236802Z","caller":"traceutil/trace.go:171","msg":"trace[867849297] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"173.752286ms","start":"2026-08-26T00:27:01.063031Z","end":"2026-08-26T00:27:01.236783Z","steps":["trace[867849297] 'process raft request' (duration: 173.600442ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:28:26.787891Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2931} {"level":"info","ts":"2026-08-26T00:28:26.895506Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2931,"took":"106.068663ms","hash":2494330379,"current-db-size-bytes":54398976,"current-db-size":"54 MB","current-db-size-in-use-bytes":29601792,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-26T00:28:26.895582Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2494330379,"revision":2931,"compact-revision":-1} {"level":"info","ts":"2026-08-26T00:30:38.782586Z","caller":"traceutil/trace.go:171","msg":"trace[838155929] transaction","detail":"{read_only:false; response_revision:6525; number_of_response:1; }","duration":"136.573587ms","start":"2026-08-26T00:30:38.645983Z","end":"2026-08-26T00:30:38.782557Z","steps":["trace[838155929] 'process raft request' (duration: 136.321173ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:33:26.795529Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5628} {"level":"info","ts":"2026-08-26T00:33:26.898746Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5628,"took":"101.61551ms","hash":3021427483,"current-db-size-bytes":54398976,"current-db-size":"54 MB","current-db-size-in-use-bytes":18563072,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-08-26T00:33:26.898809Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3021427483,"revision":5628,"compact-revision":2931} {"level":"warn","ts":"2026-08-26T00:34:17.334603Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:17.835755Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:18.336984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:18.837641Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:19.337968Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:19.583565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000443247s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-26T00:34:19.583694Z","caller":"traceutil/trace.go:171","msg":"trace[1578334756] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000624891s","start":"2026-08-26T00:34:17.583039Z","end":"2026-08-26T00:34:19.583664Z","steps":["trace[1578334756] 'agreement among raft nodes before linearized reading' (duration: 2.000456677s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:19.583769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.583029Z","time spent":"2.000720433s","remote":"127.0.0.1:54880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/26 00:34:19 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:19.83863Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:20.338933Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:20.839924Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:21.34063Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:21.583809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999634349s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-26T00:34:21.583939Z","caller":"traceutil/trace.go:171","msg":"trace[1274381889] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.999840223s","start":"2026-08-26T00:34:19.584075Z","end":"2026-08-26T00:34:21.583916Z","steps":["trace[1274381889] 'agreement among raft nodes before linearized reading' (duration: 1.99967909s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:21.584013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:19.584044Z","time spent":"1.999956916s","remote":"127.0.0.1:54890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/26 00:34:21 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:21.833629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:16.834931Z","time spent":"4.998692056s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/26 00:34:21 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:21.841848Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:22.063429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.065488Z","time spent":"4.997907682s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/26 00:34:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:22.158903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.160256Z","time spent":"4.998639098s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/26 00:34:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:22.342401Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:22.35075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.002046159s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-26T00:34:22.35089Z","caller":"traceutil/trace.go:171","msg":"trace[1949640251] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"5.002265194s","start":"2026-08-26T00:34:17.348594Z","end":"2026-08-26T00:34:22.350859Z","steps":["trace[1949640251] 'agreement among raft nodes before linearized reading' (duration: 5.00208011s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:22.351014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.348572Z","time spent":"5.002417758s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/08/26 00:34:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:22.504343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998906933s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-26T00:34:22.504441Z","caller":"traceutil/trace.go:171","msg":"trace[1910989902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.999069247s","start":"2026-08-26T00:34:17.505346Z","end":"2026-08-26T00:34:22.504416Z","steps":["trace[1910989902] 'agreement among raft nodes before linearized reading' (duration: 4.998946154s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:22.504595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.505324Z","time spent":"4.999256152s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/08/26 00:34:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:22.672213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.673729Z","time spent":"4.998470755s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} 2026/08/26 00:34:22 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:22.84315Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:23.344003Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783741,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:23.59257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000513237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-26T00:34:23.59266Z","caller":"traceutil/trace.go:171","msg":"trace[1777118523] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.00066014s","start":"2026-08-26T00:34:21.591983Z","end":"2026-08-26T00:34:23.592643Z","steps":["trace[1777118523] 'agreement among raft nodes before linearized reading' (duration: 2.000555148s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:23.592696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:21.591963Z","time spent":"2.000726222s","remote":"127.0.0.1:54880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/26 00:34:23 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:23.783921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:16.783769Z","time spent":"7.000144441s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-26T00:34:23.788223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999282827s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-26T00:34:23.788366Z","caller":"traceutil/trace.go:171","msg":"trace[856617655] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999464721s","start":"2026-08-26T00:34:18.788869Z","end":"2026-08-26T00:34:23.788334Z","steps":["trace[856617655] 'agreement among raft nodes before linearized reading' (duration: 4.999271867s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:23.788445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:18.788849Z","time spent":"4.999582853s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/08/26 00:34:23 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:23.834671Z","caller":"etcdserver/v3_server.go:909","msg":"timed out waiting for read index response (local node might have slow network)","timeout":"7s"} {"level":"warn","ts":"2026-08-26T00:34:23.834891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"7.000800647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/horizon-openstack-horizon\" ","response":"","error":"etcdserver: request timed out"} {"level":"info","ts":"2026-08-26T00:34:23.834965Z","caller":"traceutil/trace.go:171","msg":"trace[1146927145] range","detail":"{range_begin:/registry/roles/openstack/horizon-openstack-horizon; range_end:; }","duration":"7.000898909s","start":"2026-08-26T00:34:16.834043Z","end":"2026-08-26T00:34:23.834942Z","steps":["trace[1146927145] 'agreement among raft nodes before linearized reading' (duration: 7.000797647s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:23.835019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:16.833948Z","time spent":"7.001060593s","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":0,"request content":"key:\"/registry/roles/openstack/horizon-openstack-horizon\" "} {"level":"warn","ts":"2026-08-26T00:34:24.26709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.266924Z","time spent":"7.000139514s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-26T00:34:24.335343Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783753,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:24.83649Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783753,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:25.337494Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783753,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:25.537672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:18.536774Z","time spent":"7.000893429s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-08-26T00:34:25.593218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000162401s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-08-26T00:34:25.593334Z","caller":"traceutil/trace.go:171","msg":"trace[2018691726] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000373695s","start":"2026-08-26T00:34:23.592932Z","end":"2026-08-26T00:34:25.593306Z","steps":["trace[2018691726] 'agreement among raft nodes before linearized reading' (duration: 2.000196452s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:25.593876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:23.592902Z","time spent":"2.000786213s","remote":"127.0.0.1:54890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/26 00:34:25 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-26T00:34:25.83765Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":9546400012262783753,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-26T00:34:26.011969Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"9.226918445s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-26T00:34:26.013044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.386863581s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T00:34:26.013167Z","caller":"traceutil/trace.go:171","msg":"trace[1189001653] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:7705; }","duration":"8.386994584s","start":"2026-08-26T00:34:17.626154Z","end":"2026-08-26T00:34:26.013149Z","steps":["trace[1189001653] 'range keys from in-memory index tree' (duration: 8.386850021s)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:34:26.021773Z","caller":"traceutil/trace.go:171","msg":"trace[1828433507] transaction","detail":"{read_only:false; response_revision:7713; number_of_response:1; }","duration":"6.629217427s","start":"2026-08-26T00:34:19.392539Z","end":"2026-08-26T00:34:26.021756Z","steps":["trace[1828433507] 'process raft request' (duration: 6.628974002s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.021777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:21.587451Z","time spent":"4.434321662s","remote":"127.0.0.1:54942","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-26T00:34:26.0218Z","caller":"traceutil/trace.go:171","msg":"trace[943281995] transaction","detail":"{read_only:false; number_of_response:1; response_revision:7713; }","duration":"1.750449907s","start":"2026-08-26T00:34:24.271335Z","end":"2026-08-26T00:34:26.021785Z","steps":["trace[943281995] 'process raft request' (duration: 1.750363175s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.021872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:19.392499Z","time spent":"6.629320809s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T00:34:26.021898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:24.271314Z","time spent":"1.750526659s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":69,"response count":0,"response size":721,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T00:34:26.032656Z","caller":"traceutil/trace.go:171","msg":"trace[1327211653] linearizableReadLoop","detail":"{readStateIndex:8001; appliedIndex:7990; }","duration":"2.197843931s","start":"2026-08-26T00:34:23.834801Z","end":"2026-08-26T00:34:26.032645Z","steps":["trace[1327211653] 'read index received' (duration: 2.177591887s)","trace[1327211653] 'applied index is now lower than readState.Index' (duration: 20.251444ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T00:34:26.032703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.787603551s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T00:34:26.032743Z","caller":"traceutil/trace.go:171","msg":"trace[1789339720] range","detail":"{range_begin:/registry/rabbitmq.com/shovels/; range_end:/registry/rabbitmq.com/shovels0; response_count:0; response_revision:7714; }","duration":"3.787695314s","start":"2026-08-26T00:34:22.245038Z","end":"2026-08-26T00:34:26.032734Z","steps":["trace[1789339720] 'agreement among raft nodes before linearized reading' (duration: 3.787615132s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.032768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:22.245019Z","time spent":"3.787742494s","remote":"127.0.0.1:52568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/shovels/\" range_end:\"/registry/rabbitmq.com/shovels0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.032881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.556618436s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-26T00:34:26.032933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.652902874s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1853"} {"level":"info","ts":"2026-08-26T00:34:26.032945Z","caller":"traceutil/trace.go:171","msg":"trace[1667615242] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:7715; }","duration":"5.556741429s","start":"2026-08-26T00:34:20.476188Z","end":"2026-08-26T00:34:26.032929Z","steps":["trace[1667615242] 'agreement among raft nodes before linearized reading' (duration: 5.556598116s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.03298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.464399495s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-26T00:34:26.032987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:20.476157Z","time spent":"5.556819241s","remote":"127.0.0.1:49832","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":5,"response size":31,"request content":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.032951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.653527215s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-26T00:34:26.03301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.074009777s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-26T00:34:26.032996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.592484011s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-26T00:34:26.033041Z","caller":"traceutil/trace.go:171","msg":"trace[352305792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:7715; }","duration":"8.074053818s","start":"2026-08-26T00:34:17.95898Z","end":"2026-08-26T00:34:26.033033Z","steps":["trace[352305792] 'agreement among raft nodes before linearized reading' (duration: 8.073750402s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.958975Z","time spent":"8.074082209s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-26T00:34:26.033078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.993494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-26T00:34:26.033099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.968223358s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:571"} {"level":"warn","ts":"2026-08-26T00:34:26.032904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.116331807s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/horizon-openstack-horizon-db-sync\" ","response":"range_response_count:1 size:687"} {"level":"info","ts":"2026-08-26T00:34:26.033113Z","caller":"traceutil/trace.go:171","msg":"trace[1986917935] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:7715; }","duration":"3.592685135s","start":"2026-08-26T00:34:22.440363Z","end":"2026-08-26T00:34:26.033048Z","steps":["trace[1986917935] 'agreement among raft nodes before linearized reading' (duration: 3.592360528s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.261060745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T00:34:26.033204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.502620481s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1988"} {"level":"info","ts":"2026-08-26T00:34:26.033223Z","caller":"traceutil/trace.go:171","msg":"trace[1309675328] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:7715; }","duration":"8.261130307s","start":"2026-08-26T00:34:17.772084Z","end":"2026-08-26T00:34:26.033214Z","steps":["trace[1309675328] 'agreement among raft nodes before linearized reading' (duration: 8.260642716s)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:34:26.033228Z","caller":"traceutil/trace.go:171","msg":"trace[1861487336] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:7715; }","duration":"8.502643982s","start":"2026-08-26T00:34:17.530577Z","end":"2026-08-26T00:34:26.033221Z","steps":["trace[1861487336] 'agreement among raft nodes before linearized reading' (duration: 8.502171472s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.324287084s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-26T00:34:26.033266Z","caller":"traceutil/trace.go:171","msg":"trace[649202857] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:7715; }","duration":"5.324338535s","start":"2026-08-26T00:34:20.708922Z","end":"2026-08-26T00:34:26.033261Z","steps":["trace[649202857] 'agreement among raft nodes before linearized reading' (duration: 5.323854885s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.530539Z","time spent":"8.502716754s","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2012,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-08-26T00:34:26.03328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:20.708903Z","time spent":"5.324373946s","remote":"127.0.0.1:54942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":680,"response size":32,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.03322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:22.440337Z","time spent":"3.592862988s","remote":"127.0.0.1:45236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":31,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.033357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.421968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T00:34:26.03336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.477746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-26T00:34:26.033375Z","caller":"traceutil/trace.go:171","msg":"trace[1898470992] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:7715; }","duration":"432.474779ms","start":"2026-08-26T00:34:25.600896Z","end":"2026-08-26T00:34:26.033371Z","steps":["trace[1898470992] 'agreement among raft nodes before linearized reading' (duration: 432.449188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.224058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-08-26T00:34:26.033389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:25.600874Z","time spent":"432.512539ms","remote":"127.0.0.1:54880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-26T00:34:26.0334Z","caller":"traceutil/trace.go:171","msg":"trace[2104911279] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:7715; }","duration":"243.27462ms","start":"2026-08-26T00:34:25.790119Z","end":"2026-08-26T00:34:26.033394Z","steps":["trace[2104911279] 'agreement among raft nodes before linearized reading' (duration: 243.212458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.772063Z","time spent":"8.261177397s","remote":"127.0.0.1:49556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.033458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"9.158269222s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/openstack/horizon-openstack-horizon-db-init\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-08-26T00:34:26.033397Z","caller":"traceutil/trace.go:171","msg":"trace[830060256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:7715; }","duration":"245.550317ms","start":"2026-08-26T00:34:25.787838Z","end":"2026-08-26T00:34:26.033388Z","steps":["trace[830060256] 'agreement among raft nodes before linearized reading' (duration: 245.449745ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.400716ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-08-26T00:34:26.033108Z","caller":"traceutil/trace.go:171","msg":"trace[1116996466] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7715; }","duration":"360.051104ms","start":"2026-08-26T00:34:25.673046Z","end":"2026-08-26T00:34:26.033098Z","steps":["trace[1116996466] 'agreement among raft nodes before linearized reading' (duration: 360.000153ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033634Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.357006972s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/08db1feb.percona.com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-08-26T00:34:26.033651Z","caller":"traceutil/trace.go:171","msg":"trace[414905439] range","detail":"{range_begin:/registry/leases/openstack/08db1feb.percona.com; range_end:; response_count:1; response_revision:7715; }","duration":"3.357024713s","start":"2026-08-26T00:34:22.676621Z","end":"2026-08-26T00:34:26.033646Z","steps":["trace[414905439] 'agreement among raft nodes before linearized reading' (duration: 3.356065433s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:25.673033Z","time spent":"360.613966ms","remote":"127.0.0.1:52670","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.03367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:22.676597Z","time spent":"3.357069413s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":550,"request content":"key:\"/registry/leases/openstack/08db1feb.percona.com\" "} {"level":"warn","ts":"2026-08-26T00:34:26.03369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.648135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-26T00:34:26.033721Z","caller":"traceutil/trace.go:171","msg":"trace[2049321048] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:7715; }","duration":"495.702265ms","start":"2026-08-26T00:34:25.538012Z","end":"2026-08-26T00:34:26.033714Z","steps":["trace[2049321048] 'agreement among raft nodes before linearized reading' (duration: 495.626684ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:34:26.033723Z","caller":"traceutil/trace.go:171","msg":"trace[358715646] range","detail":"{range_begin:/registry/roles/openstack/horizon-openstack-horizon-db-init; range_end:; response_count:1; response_revision:7715; }","duration":"9.158565218s","start":"2026-08-26T00:34:16.875145Z","end":"2026-08-26T00:34:26.03371Z","steps":["trace[358715646] 'agreement among raft nodes before linearized reading' (duration: 9.157615768s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.03376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:25.537968Z","time spent":"495.784567ms","remote":"127.0.0.1:55034","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":40,"response size":31,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.033365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.197786824s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:551"} {"level":"info","ts":"2026-08-26T00:34:26.033797Z","caller":"traceutil/trace.go:171","msg":"trace[237145362] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:7715; }","duration":"4.198255674s","start":"2026-08-26T00:34:21.835534Z","end":"2026-08-26T00:34:26.033789Z","steps":["trace[237145362] 'agreement among raft nodes before linearized reading' (duration: 4.197221432s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.525754349s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"warn","ts":"2026-08-26T00:34:26.033137Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"6.249900995s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.80\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T00:34:26.033822Z","caller":"traceutil/trace.go:171","msg":"trace[1526430271] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:7715; }","duration":"1.52582683s","start":"2026-08-26T00:34:24.507989Z","end":"2026-08-26T00:34:26.033816Z","steps":["trace[1526430271] 'agreement among raft nodes before linearized reading' (duration: 1.52578752s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033822Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:21.835519Z","time spent":"4.198296804s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":575,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-08-26T00:34:26.033837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:24.507958Z","time spent":"1.525876342s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-08-26T00:34:26.033839Z","caller":"traceutil/trace.go:171","msg":"trace[2079749873] range","detail":"{range_begin:/registry/masterleases/162.253.55.80; range_end:; response_count:0; response_revision:7715; }","duration":"6.250667281s","start":"2026-08-26T00:34:19.783164Z","end":"2026-08-26T00:34:26.033832Z","steps":["trace[2079749873] 'agreement among raft nodes before linearized reading' (duration: 6.249616569s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.032929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.870346186s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-08-26T00:34:26.033868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:19.783136Z","time spent":"6.250726222s","remote":"127.0.0.1:54912","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":29,"request content":"key:\"/registry/masterleases/162.253.55.80\" "} {"level":"warn","ts":"2026-08-26T00:34:26.033765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:16.87513Z","time spent":"9.158623749s","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":699,"request content":"key:\"/registry/roles/openstack/horizon-openstack-horizon-db-init\" "} {"level":"info","ts":"2026-08-26T00:34:26.03389Z","caller":"traceutil/trace.go:171","msg":"trace[817926977] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7715; }","duration":"4.871347208s","start":"2026-08-26T00:34:21.16253Z","end":"2026-08-26T00:34:26.033877Z","steps":["trace[817926977] 'agreement among raft nodes before linearized reading' (duration: 4.870236404s)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:34:26.033022Z","caller":"traceutil/trace.go:171","msg":"trace[525883945] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:7715; }","duration":"8.464462295s","start":"2026-08-26T00:34:17.568546Z","end":"2026-08-26T00:34:26.033008Z","steps":["trace[525883945] 'agreement among raft nodes before linearized reading' (duration: 8.46418897s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.07508975s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-26T00:34:26.03396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.568535Z","time spent":"8.465419497s","remote":"127.0.0.1:52624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.033958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:21.162511Z","time spent":"4.87142996s","remote":"127.0.0.1:55028","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-26T00:34:26.033136Z","caller":"traceutil/trace.go:171","msg":"trace[236900326] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:7715; }","duration":"3.96828676s","start":"2026-08-26T00:34:22.064838Z","end":"2026-08-26T00:34:26.033125Z","steps":["trace[236900326] 'agreement among raft nodes before linearized reading' (duration: 3.967909312s)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:34:26.033156Z","caller":"traceutil/trace.go:171","msg":"trace[1063233621] range","detail":"{range_begin:/registry/roles/openstack/horizon-openstack-horizon-db-sync; range_end:; response_count:1; response_revision:7715; }","duration":"2.116611213s","start":"2026-08-26T00:34:23.916533Z","end":"2026-08-26T00:34:26.033144Z","steps":["trace[1063233621] 'agreement among raft nodes before linearized reading' (duration: 2.116266296s)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:34:26.032986Z","caller":"traceutil/trace.go:171","msg":"trace[1131765528] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:7715; }","duration":"5.652987945s","start":"2026-08-26T00:34:20.37998Z","end":"2026-08-26T00:34:26.032968Z","steps":["trace[1131765528] 'agreement among raft nodes before linearized reading' (duration: 5.652808211s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.033487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.683783084s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-08-26T00:34:26.034064Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:22.064821Z","time spent":"3.969235059s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":595,"request content":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" "} {"level":"warn","ts":"2026-08-26T00:34:26.034077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:23.916518Z","time spent":"2.117549183s","remote":"127.0.0.1:55150","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":711,"request content":"key:\"/registry/roles/openstack/horizon-openstack-horizon-db-sync\" "} {"level":"warn","ts":"2026-08-26T00:34:26.034085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:20.37996Z","time spent":"5.654113979s","remote":"127.0.0.1:55004","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1877,"request content":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-08-26T00:34:26.034129Z","caller":"traceutil/trace.go:171","msg":"trace[2088458334] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:7715; }","duration":"1.684417998s","start":"2026-08-26T00:34:24.349659Z","end":"2026-08-26T00:34:26.034077Z","steps":["trace[2088458334] 'agreement among raft nodes before linearized reading' (duration: 1.683758124s)"],"step_count":1} {"level":"info","ts":"2026-08-26T00:34:26.033619Z","caller":"traceutil/trace.go:171","msg":"trace[1522123975] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:1; response_revision:7715; }","duration":"493.461587ms","start":"2026-08-26T00:34:25.540149Z","end":"2026-08-26T00:34:26.033611Z","steps":["trace[1522123975] 'agreement among raft nodes before linearized reading' (duration: 493.359935ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.034236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:24.34964Z","time spent":"1.68453552s","remote":"127.0.0.1:55106","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-08-26T00:34:26.034261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:25.540144Z","time spent":"494.110631ms","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":514,"request content":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" "} {"level":"info","ts":"2026-08-26T00:34:26.034033Z","caller":"traceutil/trace.go:171","msg":"trace[6974407] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:7715; }","duration":"8.075941669s","start":"2026-08-26T00:34:17.958029Z","end":"2026-08-26T00:34:26.033971Z","steps":["trace[6974407] 'agreement among raft nodes before linearized reading' (duration: 8.074691782s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.034338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.958011Z","time spent":"8.076306507s","remote":"127.0.0.1:39128","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":31,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"info","ts":"2026-08-26T00:34:26.033026Z","caller":"traceutil/trace.go:171","msg":"trace[14390816] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:7715; }","duration":"3.653637128s","start":"2026-08-26T00:34:22.379378Z","end":"2026-08-26T00:34:26.033015Z","steps":["trace[14390816] 'agreement among raft nodes before linearized reading' (duration: 3.653394792s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.034437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:22.379355Z","time spent":"3.655064059s","remote":"127.0.0.1:55344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":40,"response size":31,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.033549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"8.581318585s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T00:34:26.03556Z","caller":"traceutil/trace.go:171","msg":"trace[990679917] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:7715; }","duration":"8.583356969s","start":"2026-08-26T00:34:17.452183Z","end":"2026-08-26T00:34:26.03554Z","steps":["trace[990679917] 'agreement among raft nodes before linearized reading' (duration: 8.580573599s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.036059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:17.452164Z","time spent":"8.583869419s","remote":"127.0.0.1:49606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-08-26T00:34:26.038651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.878200591s","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-08-26T00:34:26.038801Z","caller":"traceutil/trace.go:171","msg":"trace[642506121] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7715; }","duration":"3.878375314s","start":"2026-08-26T00:34:22.160398Z","end":"2026-08-26T00:34:26.038773Z","steps":["trace[642506121] 'agreement among raft nodes before linearized reading' (duration: 3.872313844s)"],"step_count":1} {"level":"warn","ts":"2026-08-26T00:34:26.041227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T00:34:22.160381Z","time spent":"3.880818967s","remote":"127.0.0.1:55106","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "}