{"level":"warn","ts":"2026-04-20T04:44:28.557293Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:44:28.557377Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-20T04:44:28.557444Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T04:44:28.557458Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-20T04:44:28.557484Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T04:44:28.558123Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-04-20T04:44:28.558201Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-20T04:44:28.563723Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.278114ms"} {"level":"info","ts":"2026-04-20T04:44:28.573743Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-04-20T04:44:28.573846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T04:44:28.57388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-04-20T04:44:28.573904Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T04:44:28.573925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-04-20T04:44:28.573965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-04-20T04:44:28.585747Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T04:44:28.587266Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T04:44:28.588442Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-20T04:44:28.591691Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T04:44:28.592064Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T04:44:28.59263Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-04-20T04:44:28.59279Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-04-20T04:44:28.592876Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T04:44:28.592921Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T04:44:28.592938Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-20T04:44:28.601591Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-20T04:44:28.601652Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-20T04:44:28.601702Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-04-20T04:44:28.602253Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T04:44:28.602312Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T04:44:29.576366Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T04:44:29.576431Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T04:44:29.576471Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-04-20T04:44:29.576496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-04-20T04:44:29.576508Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-20T04:44:29.576524Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-04-20T04:44:29.576543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-04-20T04:44:29.708005Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T04:44:29.708028Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:44:29.708062Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T04:44:29.708202Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T04:44:29.708225Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T04:44:29.708274Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:44:29.712121Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T04:44:29.712183Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-04-20T04:44:29.752616Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:44:29.752767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:44:29.75281Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T04:45:04.669917Z","caller":"traceutil/trace.go:171","msg":"trace[773653473] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"199.296756ms","start":"2026-04-20T04:45:04.470586Z","end":"2026-04-20T04:45:04.669883Z","steps":["trace[773653473] 'process raft request' (duration: 199.145398ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:45:05.346547Z","caller":"traceutil/trace.go:171","msg":"trace[132361409] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"465.382236ms","start":"2026-04-20T04:45:04.881141Z","end":"2026-04-20T04:45:05.346523Z","steps":["trace[132361409] 'read index received' (duration: 446.632415ms)","trace[132361409] 'applied index is now lower than readState.Index' (duration: 18.748841ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:45:05.346624Z","caller":"traceutil/trace.go:171","msg":"trace[716861153] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"480.966969ms","start":"2026-04-20T04:45:04.86562Z","end":"2026-04-20T04:45:05.346587Z","steps":["trace[716861153] 'process raft request' (duration: 462.189946ms)","trace[716861153] 'compare' (duration: 18.584082ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:45:05.346831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.629651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:45:05.347004Z","caller":"traceutil/trace.go:171","msg":"trace[962585547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:623; }","duration":"465.868804ms","start":"2026-04-20T04:45:04.881102Z","end":"2026-04-20T04:45:05.34697Z","steps":["trace[962585547] 'agreement among raft nodes before linearized reading' (duration: 465.530645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:45:05.347053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:45:04.881088Z","time spent":"465.957029ms","remote":"127.0.0.1:50308","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T04:45:05.347501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:45:04.865592Z","time spent":"481.110958ms","remote":"127.0.0.1:50562","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T04:45:05.380313Z","caller":"traceutil/trace.go:171","msg":"trace[697978582] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"334.974784ms","start":"2026-04-20T04:45:05.045322Z","end":"2026-04-20T04:45:05.380297Z","steps":["trace[697978582] 'process raft request' (duration: 334.811574ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:45:05.380602Z","caller":"traceutil/trace.go:171","msg":"trace[1772031897] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"289.570802ms","start":"2026-04-20T04:45:05.090978Z","end":"2026-04-20T04:45:05.380549Z","steps":["trace[1772031897] 'process raft request' (duration: 289.259403ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:45:05.380718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.354459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-04-20T04:45:05.380773Z","caller":"traceutil/trace.go:171","msg":"trace[667843767] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:625; }","duration":"392.437893ms","start":"2026-04-20T04:45:04.988308Z","end":"2026-04-20T04:45:05.380745Z","steps":["trace[667843767] 'agreement among raft nodes before linearized reading' (duration: 392.351789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:45:05.380808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:45:04.988296Z","time spent":"392.506048ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-20T04:45:05.380624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.145472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-20T04:45:05.380846Z","caller":"traceutil/trace.go:171","msg":"trace[1034680655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:625; }","duration":"209.431437ms","start":"2026-04-20T04:45:05.171398Z","end":"2026-04-20T04:45:05.380829Z","steps":["trace[1034680655] 'agreement among raft nodes before linearized reading' (duration: 209.065397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:45:05.382351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:45:05.045286Z","time spent":"335.077589ms","remote":"127.0.0.1:50506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:45:07.048683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.946098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:45:07.048826Z","caller":"traceutil/trace.go:171","msg":"trace[1860035672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:639; }","duration":"164.148529ms","start":"2026-04-20T04:45:06.884646Z","end":"2026-04-20T04:45:07.048794Z","steps":["trace[1860035672] 'range keys from in-memory index tree' (duration: 163.856753ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:45:20.716199Z","caller":"traceutil/trace.go:171","msg":"trace[1335153975] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"244.80069ms","start":"2026-04-20T04:45:20.471369Z","end":"2026-04-20T04:45:20.71617Z","steps":["trace[1335153975] 'process raft request' (duration: 244.633731ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:32.432405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.730683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-751043a3-8c52-4fd2-9ed6-d778b8bca73c\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-04-20T04:46:32.432485Z","caller":"traceutil/trace.go:171","msg":"trace[1479664771] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-751043a3-8c52-4fd2-9ed6-d778b8bca73c; range_end:; response_count:1; response_revision:1833; }","duration":"178.854713ms","start":"2026-04-20T04:46:32.253612Z","end":"2026-04-20T04:46:32.432467Z","steps":["trace[1479664771] 'range keys from in-memory index tree' (duration: 178.50198ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:44.170552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.301974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:46:44.170653Z","caller":"traceutil/trace.go:171","msg":"trace[1796788195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1933; }","duration":"182.489417ms","start":"2026-04-20T04:46:43.988143Z","end":"2026-04-20T04:46:44.170632Z","steps":["trace[1796788195] 'range keys from in-memory index tree' (duration: 182.220002ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:44.170665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.42141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-20T04:46:44.170785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.07572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-20T04:46:44.170893Z","caller":"traceutil/trace.go:171","msg":"trace[1328955061] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1933; }","duration":"139.208523ms","start":"2026-04-20T04:46:44.03166Z","end":"2026-04-20T04:46:44.170869Z","steps":["trace[1328955061] 'range keys from in-memory index tree' (duration: 138.916869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:44.170568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.071084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-04-20T04:46:44.171028Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.825179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T04:46:44.171021Z","caller":"traceutil/trace.go:171","msg":"trace[181281652] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1933; }","duration":"153.551232ms","start":"2026-04-20T04:46:44.017437Z","end":"2026-04-20T04:46:44.170989Z","steps":["trace[181281652] 'range keys from in-memory index tree' (duration: 152.904193ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:44.171117Z","caller":"traceutil/trace.go:171","msg":"trace[958553925] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1933; }","duration":"151.960142ms","start":"2026-04-20T04:46:44.019143Z","end":"2026-04-20T04:46:44.171103Z","steps":["trace[958553925] 'range keys from in-memory index tree' (duration: 151.679978ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:44.171136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.081538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-20T04:46:44.171224Z","caller":"traceutil/trace.go:171","msg":"trace[863708514] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1933; }","duration":"154.224771ms","start":"2026-04-20T04:46:44.016984Z","end":"2026-04-20T04:46:44.171209Z","steps":["trace[863708514] 'range keys from in-memory index tree' (duration: 153.917747ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:44.170725Z","caller":"traceutil/trace.go:171","msg":"trace[51685107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1933; }","duration":"156.516452ms","start":"2026-04-20T04:46:44.014191Z","end":"2026-04-20T04:46:44.170707Z","steps":["trace[51685107] 'range keys from in-memory index tree' (duration: 156.324357ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:44.300142Z","caller":"traceutil/trace.go:171","msg":"trace[304415544] transaction","detail":"{read_only:false; response_revision:1938; number_of_response:1; }","duration":"123.014597ms","start":"2026-04-20T04:46:44.177078Z","end":"2026-04-20T04:46:44.300092Z","steps":["trace[304415544] 'process raft request' (duration: 122.970697ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:44.300268Z","caller":"traceutil/trace.go:171","msg":"trace[2064902904] transaction","detail":"{read_only:false; response_revision:1936; number_of_response:1; }","duration":"124.239134ms","start":"2026-04-20T04:46:44.176014Z","end":"2026-04-20T04:46:44.300253Z","steps":["trace[2064902904] 'process raft request' (duration: 120.128459ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:44.300323Z","caller":"traceutil/trace.go:171","msg":"trace[579771102] transaction","detail":"{read_only:false; response_revision:1937; number_of_response:1; }","duration":"124.030441ms","start":"2026-04-20T04:46:44.176271Z","end":"2026-04-20T04:46:44.300302Z","steps":["trace[579771102] 'process raft request' (duration: 123.737067ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:45.126737Z","caller":"traceutil/trace.go:171","msg":"trace[519214606] transaction","detail":"{read_only:false; response_revision:1939; number_of_response:1; }","duration":"236.041025ms","start":"2026-04-20T04:46:44.890674Z","end":"2026-04-20T04:46:45.126715Z","steps":["trace[519214606] 'process raft request' (duration: 235.911773ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:45.126748Z","caller":"traceutil/trace.go:171","msg":"trace[530102761] linearizableReadLoop","detail":"{readStateIndex:2008; appliedIndex:2008; }","duration":"229.500619ms","start":"2026-04-20T04:46:44.897217Z","end":"2026-04-20T04:46:45.126718Z","steps":["trace[530102761] 'read index received' (duration: 229.488318ms)","trace[530102761] 'applied index is now lower than readState.Index' (duration: 9.661µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:46:45.126991Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.759932ms","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-04-20T04:46:45.127049Z","caller":"traceutil/trace.go:171","msg":"trace[726579002] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:1939; }","duration":"229.827483ms","start":"2026-04-20T04:46:44.897207Z","end":"2026-04-20T04:46:45.127034Z","steps":["trace[726579002] 'agreement among raft nodes before linearized reading' (duration: 229.62157ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:46:45.132677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.349392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:46:45.132658Z","caller":"traceutil/trace.go:171","msg":"trace[498528224] transaction","detail":"{read_only:false; response_revision:1940; number_of_response:1; }","duration":"231.418278ms","start":"2026-04-20T04:46:44.901217Z","end":"2026-04-20T04:46:45.132635Z","steps":["trace[498528224] 'process raft request' (duration: 230.212331ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:46:45.132724Z","caller":"traceutil/trace.go:171","msg":"trace[1472270760] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1940; }","duration":"233.411303ms","start":"2026-04-20T04:46:44.8993Z","end":"2026-04-20T04:46:45.132711Z","steps":["trace[1472270760] 'agreement among raft nodes before linearized reading' (duration: 233.326652ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:47:20.462597Z","caller":"traceutil/trace.go:171","msg":"trace[495059982] transaction","detail":"{read_only:false; response_revision:2141; number_of_response:1; }","duration":"120.313451ms","start":"2026-04-20T04:47:20.341492Z","end":"2026-04-20T04:47:20.461806Z","steps":["trace[495059982] 'process raft request' (duration: 120.054644ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:47:20.780881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.40705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T04:47:20.781112Z","caller":"traceutil/trace.go:171","msg":"trace[135008739] transaction","detail":"{read_only:false; response_revision:2142; number_of_response:1; }","duration":"314.821036ms","start":"2026-04-20T04:47:20.466271Z","end":"2026-04-20T04:47:20.781092Z","steps":["trace[135008739] 'process raft request' (duration: 132.806159ms)","trace[135008739] 'compare' (duration: 181.281546ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:47:20.781154Z","caller":"traceutil/trace.go:171","msg":"trace[864042041] linearizableReadLoop","detail":"{readStateIndex:2220; appliedIndex:2217; }","duration":"245.496145ms","start":"2026-04-20T04:47:20.53564Z","end":"2026-04-20T04:47:20.781136Z","steps":["trace[864042041] 'read index received' (duration: 63.359904ms)","trace[864042041] 'applied index is now lower than readState.Index' (duration: 182.134851ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:47:20.781181Z","caller":"traceutil/trace.go:171","msg":"trace[2136014953] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"314.515807ms","start":"2026-04-20T04:47:20.466645Z","end":"2026-04-20T04:47:20.781161Z","steps":["trace[2136014953] 'process raft request' (duration: 314.355922ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:47:20.781192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:47:20.466249Z","time spent":"314.915609ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:47:20.781276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:47:20.466616Z","time spent":"314.61341ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:47:20.781354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.705141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/percona-xtradb-haproxy-0.18a7f73d443714ca\" ","response":"range_response_count:1 size:846"} {"level":"info","ts":"2026-04-20T04:47:20.781407Z","caller":"traceutil/trace.go:171","msg":"trace[2030460643] range","detail":"{range_begin:/registry/events/openstack/percona-xtradb-haproxy-0.18a7f73d443714ca; range_end:; response_count:1; response_revision:2144; }","duration":"245.785454ms","start":"2026-04-20T04:47:20.535606Z","end":"2026-04-20T04:47:20.781391Z","steps":["trace[2030460643] 'agreement among raft nodes before linearized reading' (duration: 245.597768ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:47:20.78145Z","caller":"traceutil/trace.go:171","msg":"trace[1026140324] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"314.701383ms","start":"2026-04-20T04:47:20.466735Z","end":"2026-04-20T04:47:20.781437Z","steps":["trace[1026140324] 'process raft request' (duration: 314.342762ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:47:20.781528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:47:20.466722Z","time spent":"314.767314ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:47:20.958305Z","caller":"traceutil/trace.go:171","msg":"trace[176166436] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"174.894548ms","start":"2026-04-20T04:47:20.783384Z","end":"2026-04-20T04:47:20.958279Z","steps":["trace[176166436] 'process raft request' (duration: 170.981142ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:48:13.134403Z","caller":"traceutil/trace.go:171","msg":"trace[1878834974] linearizableReadLoop","detail":"{readStateIndex:2615; appliedIndex:2614; }","duration":"104.2154ms","start":"2026-04-20T04:48:13.030166Z","end":"2026-04-20T04:48:13.134381Z","steps":["trace[1878834974] 'read index received' (duration: 104.105266ms)","trace[1878834974] 'applied index is now lower than readState.Index' (duration: 109.094µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:48:13.134453Z","caller":"traceutil/trace.go:171","msg":"trace[1954332847] transaction","detail":"{read_only:false; response_revision:2526; number_of_response:1; }","duration":"105.354097ms","start":"2026-04-20T04:48:13.029068Z","end":"2026-04-20T04:48:13.134422Z","steps":["trace[1954332847] 'process raft request' (duration: 105.169789ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:48:13.134701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.498153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5683"} {"level":"info","ts":"2026-04-20T04:48:13.134795Z","caller":"traceutil/trace.go:171","msg":"trace[947208846] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2526; }","duration":"104.618187ms","start":"2026-04-20T04:48:13.030154Z","end":"2026-04-20T04:48:13.134772Z","steps":["trace[947208846] 'agreement among raft nodes before linearized reading' (duration: 104.341465ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:48:13.135845Z","caller":"traceutil/trace.go:171","msg":"trace[1337667522] transaction","detail":"{read_only:false; response_revision:2527; number_of_response:1; }","duration":"103.248ms","start":"2026-04-20T04:48:13.032562Z","end":"2026-04-20T04:48:13.13581Z","steps":["trace[1337667522] 'process raft request' (duration: 103.122705ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:48:13.135893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.890058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T04:48:13.136065Z","caller":"traceutil/trace.go:171","msg":"trace[1375135538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2527; }","duration":"105.085635ms","start":"2026-04-20T04:48:13.030956Z","end":"2026-04-20T04:48:13.136042Z","steps":["trace[1375135538] 'agreement among raft nodes before linearized reading' (duration: 104.822605ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:48:44.665118Z","caller":"traceutil/trace.go:171","msg":"trace[804497592] transaction","detail":"{read_only:false; response_revision:2698; number_of_response:1; }","duration":"132.60844ms","start":"2026-04-20T04:48:44.532471Z","end":"2026-04-20T04:48:44.66508Z","steps":["trace[804497592] 'process raft request' (duration: 132.369909ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:48:49.858621Z","caller":"traceutil/trace.go:171","msg":"trace[777867838] transaction","detail":"{read_only:false; response_revision:2726; number_of_response:1; }","duration":"110.187488ms","start":"2026-04-20T04:48:49.748406Z","end":"2026-04-20T04:48:49.858594Z","steps":["trace[777867838] 'process raft request' (duration: 109.998208ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:48:50.093884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.340538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/auth-system/keycloak-0.18a7f750eb7b3caf\" ","response":"range_response_count:1 size:781"} {"level":"info","ts":"2026-04-20T04:48:50.094095Z","caller":"traceutil/trace.go:171","msg":"trace[15545683] range","detail":"{range_begin:/registry/events/auth-system/keycloak-0.18a7f750eb7b3caf; range_end:; response_count:1; response_revision:2726; }","duration":"150.707836ms","start":"2026-04-20T04:48:49.94337Z","end":"2026-04-20T04:48:50.094078Z","steps":["trace[15545683] 'range keys from in-memory index tree' (duration: 150.177571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:48:50.094171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.272391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-20T04:48:50.094277Z","caller":"traceutil/trace.go:171","msg":"trace[101398933] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2726; }","duration":"151.399896ms","start":"2026-04-20T04:48:49.942852Z","end":"2026-04-20T04:48:50.094252Z","steps":["trace[101398933] 'range keys from in-memory index tree' (duration: 151.090793ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:33.35158Z","caller":"traceutil/trace.go:171","msg":"trace[352376187] transaction","detail":"{read_only:false; response_revision:3274; number_of_response:1; }","duration":"104.264594ms","start":"2026-04-20T04:50:33.247295Z","end":"2026-04-20T04:50:33.35156Z","steps":["trace[352376187] 'process raft request' (duration: 104.189094ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:50:33.620131Z","caller":"traceutil/trace.go:171","msg":"trace[89985578] transaction","detail":"{read_only:false; response_revision:3275; number_of_response:1; }","duration":"236.9914ms","start":"2026-04-20T04:50:33.383107Z","end":"2026-04-20T04:50:33.620098Z","steps":["trace[89985578] 'process raft request' (duration: 208.009219ms)","trace[89985578] 'compare' (duration: 28.763691ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:50:56.353698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.55045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T04:50:56.353726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.355826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-20T04:50:56.353791Z","caller":"traceutil/trace.go:171","msg":"trace[1768643269] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:3474; }","duration":"470.714172ms","start":"2026-04-20T04:50:55.883059Z","end":"2026-04-20T04:50:56.353773Z","steps":["trace[1768643269] 'range keys from in-memory index tree' (duration: 470.45226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:56.353803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"350.055647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T04:50:56.353811Z","caller":"traceutil/trace.go:171","msg":"trace[835525770] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3474; }","duration":"582.469627ms","start":"2026-04-20T04:50:55.771322Z","end":"2026-04-20T04:50:56.353792Z","steps":["trace[835525770] 'range keys from in-memory index tree' (duration: 582.139464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:56.353831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:50:55.883036Z","time spent":"470.786942ms","remote":"127.0.0.1:50296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-20T04:50:56.353863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:50:55.771313Z","time spent":"582.540617ms","remote":"127.0.0.1:50510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-20T04:50:56.353964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.191343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-20T04:50:56.354053Z","caller":"traceutil/trace.go:171","msg":"trace[891976389] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3474; }","duration":"350.341728ms","start":"2026-04-20T04:50:56.003685Z","end":"2026-04-20T04:50:56.354027Z","steps":["trace[891976389] 'range keys from in-memory index tree' (duration: 349.839096ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:56.354069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.949038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T04:50:56.354101Z","caller":"traceutil/trace.go:171","msg":"trace[1269447698] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:3474; }","duration":"379.00309ms","start":"2026-04-20T04:50:55.975088Z","end":"2026-04-20T04:50:56.354091Z","steps":["trace[1269447698] 'range keys from in-memory index tree' (duration: 378.846218ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:56.354099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:50:56.003664Z","time spent":"350.423359ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T04:50:56.354126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:50:55.975077Z","time spent":"379.04363ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T04:50:56.354126Z","caller":"traceutil/trace.go:171","msg":"trace[849653426] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3474; }","duration":"345.299143ms","start":"2026-04-20T04:50:56.008729Z","end":"2026-04-20T04:50:56.354028Z","steps":["trace[849653426] 'range keys from in-memory index tree' (duration: 345.070001ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:50:56.35418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:50:56.008722Z","time spent":"345.444184ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-20T04:50:56.931495Z","caller":"traceutil/trace.go:171","msg":"trace[306138352] transaction","detail":"{read_only:false; response_revision:3481; number_of_response:1; }","duration":"182.49927ms","start":"2026-04-20T04:50:56.748968Z","end":"2026-04-20T04:50:56.931467Z","steps":["trace[306138352] 'process raft request' (duration: 182.219698ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:32.63473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.261227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T04:52:32.634793Z","caller":"traceutil/trace.go:171","msg":"trace[1450382540] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4646; }","duration":"194.370029ms","start":"2026-04-20T04:52:32.440409Z","end":"2026-04-20T04:52:32.634779Z","steps":["trace[1450382540] 'count revisions from in-memory index tree' (duration: 194.179485ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:32.635001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.877043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:52:32.635028Z","caller":"traceutil/trace.go:171","msg":"trace[1404125398] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:4646; }","duration":"137.937215ms","start":"2026-04-20T04:52:32.497083Z","end":"2026-04-20T04:52:32.635021Z","steps":["trace[1404125398] 'count revisions from in-memory index tree' (duration: 137.828582ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:32.635166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.833778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3d61f0b5-658e-4347-8fb3-5698c2e224f1\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-04-20T04:52:32.635184Z","caller":"traceutil/trace.go:171","msg":"trace[1191343999] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3d61f0b5-658e-4347-8fb3-5698c2e224f1; range_end:; response_count:1; response_revision:4646; }","duration":"101.8839ms","start":"2026-04-20T04:52:32.533294Z","end":"2026-04-20T04:52:32.635178Z","steps":["trace[1191343999] 'range keys from in-memory index tree' (duration: 101.680723ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.227108Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14920880390507219467,"retry-timeout":"500ms"} {"level":"info","ts":"2026-04-20T04:52:33.398093Z","caller":"traceutil/trace.go:171","msg":"trace[2128157046] transaction","detail":"{read_only:false; response_revision:4648; number_of_response:1; }","duration":"691.444266ms","start":"2026-04-20T04:52:32.706621Z","end":"2026-04-20T04:52:33.398065Z","steps":["trace[2128157046] 'process raft request' (duration: 691.138558ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:33.39803Z","caller":"traceutil/trace.go:171","msg":"trace[261967966] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"685.98123ms","start":"2026-04-20T04:52:32.712026Z","end":"2026-04-20T04:52:33.398007Z","steps":["trace[261967966] 'process raft request' (duration: 685.920869ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.398375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.712012Z","time spent":"686.306029ms","remote":"127.0.0.1:50510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3748,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:52:33.398398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.706598Z","time spent":"691.655391ms","remote":"127.0.0.1:50392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:52:33.427903Z","caller":"traceutil/trace.go:171","msg":"trace[2135444496] linearizableReadLoop","detail":"{readStateIndex:4818; appliedIndex:4815; }","duration":"701.889885ms","start":"2026-04-20T04:52:32.725989Z","end":"2026-04-20T04:52:33.427879Z","steps":["trace[2135444496] 'read index received' (duration: 671.858606ms)","trace[2135444496] 'applied index is now lower than readState.Index' (duration: 30.029969ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:33.428152Z","caller":"traceutil/trace.go:171","msg":"trace[1013045882] transaction","detail":"{read_only:false; response_revision:4650; number_of_response:1; }","duration":"560.237962ms","start":"2026-04-20T04:52:32.867723Z","end":"2026-04-20T04:52:33.427961Z","steps":["trace[1013045882] 'process raft request' (duration: 559.987455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.428437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.837552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T04:52:33.428482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.388341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T04:52:33.428483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.596209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T04:52:33.428497Z","caller":"traceutil/trace.go:171","msg":"trace[345416127] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4650; }","duration":"545.916093ms","start":"2026-04-20T04:52:32.882566Z","end":"2026-04-20T04:52:33.428482Z","steps":["trace[345416127] 'agreement among raft nodes before linearized reading' (duration: 545.827291ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:33.428535Z","caller":"traceutil/trace.go:171","msg":"trace[1056788146] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4650; }","duration":"482.467783ms","start":"2026-04-20T04:52:32.946051Z","end":"2026-04-20T04:52:33.428519Z","steps":["trace[1056788146] 'agreement among raft nodes before linearized reading' (duration: 482.315479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.428542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.882558Z","time spent":"545.977825ms","remote":"127.0.0.1:50296","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T04:52:33.428542Z","caller":"traceutil/trace.go:171","msg":"trace[26254808] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4650; }","duration":"544.676991ms","start":"2026-04-20T04:52:32.88385Z","end":"2026-04-20T04:52:33.428527Z","steps":["trace[26254808] 'agreement among raft nodes before linearized reading' (duration: 544.511437ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.428588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.946033Z","time spent":"482.545055ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-20T04:52:33.428612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.88384Z","time spent":"544.761903ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-20T04:52:33.428793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.655176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-20T04:52:33.428844Z","caller":"traceutil/trace.go:171","msg":"trace[776663927] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4650; }","duration":"363.743188ms","start":"2026-04-20T04:52:33.065088Z","end":"2026-04-20T04:52:33.428831Z","steps":["trace[776663927] 'agreement among raft nodes before linearized reading' (duration: 363.611625ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.428887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:33.065066Z","time spent":"363.81147ms","remote":"127.0.0.1:50510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12236,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-20T04:52:33.428935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.957731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T04:52:33.428977Z","caller":"traceutil/trace.go:171","msg":"trace[21055268] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4650; }","duration":"564.044294ms","start":"2026-04-20T04:52:32.864923Z","end":"2026-04-20T04:52:33.428967Z","steps":["trace[21055268] 'agreement among raft nodes before linearized reading' (duration: 563.926281ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.428136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"702.140273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"warn","ts":"2026-04-20T04:52:33.429082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.864899Z","time spent":"564.148026ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-04-20T04:52:33.429118Z","caller":"traceutil/trace.go:171","msg":"trace[1189062481] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:4650; }","duration":"703.18251ms","start":"2026-04-20T04:52:32.725916Z","end":"2026-04-20T04:52:33.429099Z","steps":["trace[1189062481] 'agreement among raft nodes before linearized reading' (duration: 702.136753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:33.429206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.725891Z","time spent":"703.296644ms","remote":"127.0.0.1:50498","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":443,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-04-20T04:52:33.429249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:32.867704Z","time spent":"560.637183ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:52:38.638342Z","caller":"traceutil/trace.go:171","msg":"trace[999873743] transaction","detail":"{read_only:false; response_revision:4743; number_of_response:1; }","duration":"129.917096ms","start":"2026-04-20T04:52:38.508379Z","end":"2026-04-20T04:52:38.638297Z","steps":["trace[999873743] 'process raft request' (duration: 129.70037ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:38.945857Z","caller":"traceutil/trace.go:171","msg":"trace[902201978] linearizableReadLoop","detail":"{readStateIndex:4916; appliedIndex:4915; }","duration":"299.825725ms","start":"2026-04-20T04:52:38.646Z","end":"2026-04-20T04:52:38.945826Z","steps":["trace[902201978] 'read index received' (duration: 295.190639ms)","trace[902201978] 'applied index is now lower than readState.Index' (duration: 4.633766ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:52:38.945921Z","caller":"traceutil/trace.go:171","msg":"trace[1806235874] transaction","detail":"{read_only:false; response_revision:4744; number_of_response:1; }","duration":"303.065273ms","start":"2026-04-20T04:52:38.642823Z","end":"2026-04-20T04:52:38.945888Z","steps":["trace[1806235874] 'process raft request' (duration: 298.52265ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:38.946025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:38.642806Z","time spent":"303.162355ms","remote":"127.0.0.1:50392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":720,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T04:52:38.946173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.897857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-04-20T04:52:38.946236Z","caller":"traceutil/trace.go:171","msg":"trace[849938446] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4744; }","duration":"270.00289ms","start":"2026-04-20T04:52:38.676217Z","end":"2026-04-20T04:52:38.94622Z","steps":["trace[849938446] 'agreement among raft nodes before linearized reading' (duration: 269.792494ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:38.946452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.145529ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T04:52:38.946551Z","caller":"traceutil/trace.go:171","msg":"trace[1361558197] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:4744; }","duration":"257.22259ms","start":"2026-04-20T04:52:38.689264Z","end":"2026-04-20T04:52:38.946486Z","steps":["trace[1361558197] 'agreement among raft nodes before linearized reading' (duration: 257.156599ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:38.946878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.874104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:9221"} {"level":"info","ts":"2026-04-20T04:52:38.94692Z","caller":"traceutil/trace.go:171","msg":"trace[1359421008] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4744; }","duration":"300.955466ms","start":"2026-04-20T04:52:38.645953Z","end":"2026-04-20T04:52:38.946908Z","steps":["trace[1359421008] 'agreement among raft nodes before linearized reading' (duration: 299.971058ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:38.947016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:38.645935Z","time spent":"301.070819ms","remote":"127.0.0.1:50510","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":9242,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-04-20T04:52:39.480763Z","caller":"traceutil/trace.go:171","msg":"trace[1324847772] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"342.599246ms","start":"2026-04-20T04:52:39.138135Z","end":"2026-04-20T04:52:39.480735Z","steps":["trace[1324847772] 'process raft request' (duration: 340.652162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:39.480908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:39.138124Z","time spent":"342.707989ms","remote":"127.0.0.1:50392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:52:39.843485Z","caller":"traceutil/trace.go:171","msg":"trace[1849826471] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"342.499164ms","start":"2026-04-20T04:52:39.500925Z","end":"2026-04-20T04:52:39.843424Z","steps":["trace[1849826471] 'process raft request' (duration: 341.876886ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:39.843633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:52:39.500903Z","time spent":"342.661639ms","remote":"127.0.0.1:50392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":790,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T04:52:39.843855Z","caller":"traceutil/trace.go:171","msg":"trace[2139665457] linearizableReadLoop","detail":"{readStateIndex:4921; appliedIndex:4921; }","duration":"264.817634ms","start":"2026-04-20T04:52:39.578777Z","end":"2026-04-20T04:52:39.843595Z","steps":["trace[2139665457] 'read index received' (duration: 264.808914ms)","trace[2139665457] 'applied index is now lower than readState.Index' (duration: 7.34µs)"],"step_count":2} {"level":"warn","ts":"2026-04-20T04:52:39.844305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"265.522883ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T04:52:39.844357Z","caller":"traceutil/trace.go:171","msg":"trace[1014585830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4749; }","duration":"265.615295ms","start":"2026-04-20T04:52:39.578726Z","end":"2026-04-20T04:52:39.844341Z","steps":["trace[1014585830] 'agreement among raft nodes before linearized reading' (duration: 265.382809ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:39.84612Z","caller":"traceutil/trace.go:171","msg":"trace[1216980099] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"244.027984ms","start":"2026-04-20T04:52:39.602079Z","end":"2026-04-20T04:52:39.846107Z","steps":["trace[1216980099] 'process raft request' (duration: 243.659243ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:39.846229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.513403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-04-20T04:52:39.846278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.165453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-20T04:52:39.846313Z","caller":"traceutil/trace.go:171","msg":"trace[147757932] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4751; }","duration":"261.644787ms","start":"2026-04-20T04:52:39.584653Z","end":"2026-04-20T04:52:39.846298Z","steps":["trace[147757932] 'agreement among raft nodes before linearized reading' (duration: 261.329038ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:39.846366Z","caller":"traceutil/trace.go:171","msg":"trace[424107793] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"178.544917ms","start":"2026-04-20T04:52:39.667813Z","end":"2026-04-20T04:52:39.846358Z","steps":["trace[424107793] 'process raft request' (duration: 178.085315ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:52:39.846507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.88238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-04-20T04:52:39.84654Z","caller":"traceutil/trace.go:171","msg":"trace[2123002899] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4751; }","duration":"258.933862ms","start":"2026-04-20T04:52:39.587598Z","end":"2026-04-20T04:52:39.846532Z","steps":["trace[2123002899] 'agreement among raft nodes before linearized reading' (duration: 258.85188ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:39.846333Z","caller":"traceutil/trace.go:171","msg":"trace[1329026909] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4751; }","duration":"257.213224ms","start":"2026-04-20T04:52:39.58909Z","end":"2026-04-20T04:52:39.846303Z","steps":["trace[1329026909] 'agreement among raft nodes before linearized reading' (duration: 257.123682ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:52:49.712902Z","caller":"traceutil/trace.go:171","msg":"trace[1467002743] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"199.264102ms","start":"2026-04-20T04:52:49.513608Z","end":"2026-04-20T04:52:49.712872Z","steps":["trace[1467002743] 'process raft request' (duration: 198.663174ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:30.513912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.181128ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-20T04:53:30.513975Z","caller":"traceutil/trace.go:171","msg":"trace[872520956] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5235; }","duration":"113.302832ms","start":"2026-04-20T04:53:30.400659Z","end":"2026-04-20T04:53:30.513962Z","steps":["trace[872520956] 'range keys from in-memory index tree' (duration: 113.023653ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:53:30.514279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.069753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:572"} {"level":"info","ts":"2026-04-20T04:53:30.514301Z","caller":"traceutil/trace.go:171","msg":"trace[1108456442] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:5235; }","duration":"116.140076ms","start":"2026-04-20T04:53:30.398153Z","end":"2026-04-20T04:53:30.514293Z","steps":["trace[1108456442] 'range keys from in-memory index tree' (duration: 115.970139ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:29.734841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2937} {"level":"info","ts":"2026-04-20T04:54:29.799974Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2937,"took":"63.742585ms","hash":4183049577,"current-db-size-bytes":53694464,"current-db-size":"54 MB","current-db-size-in-use-bytes":30138368,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-20T04:54:29.800046Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4183049577,"revision":2937,"compact-revision":-1} {"level":"info","ts":"2026-04-20T04:54:32.764673Z","caller":"traceutil/trace.go:171","msg":"trace[1363718011] transaction","detail":"{read_only:false; response_revision:5683; number_of_response:1; }","duration":"594.206508ms","start":"2026-04-20T04:54:32.170436Z","end":"2026-04-20T04:54:32.764642Z","steps":["trace[1363718011] 'process raft request' (duration: 593.957078ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.764929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:32.170406Z","time spent":"594.434457ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T04:54:32.806722Z","caller":"traceutil/trace.go:171","msg":"trace[559335297] linearizableReadLoop","detail":"{readStateIndex:5884; appliedIndex:5882; }","duration":"298.679572ms","start":"2026-04-20T04:54:32.508011Z","end":"2026-04-20T04:54:32.80669Z","steps":["trace[559335297] 'read index received' (duration: 256.376542ms)","trace[559335297] 'applied index is now lower than readState.Index' (duration: 42.30151ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T04:54:32.80679Z","caller":"traceutil/trace.go:171","msg":"trace[1895875139] transaction","detail":"{read_only:false; response_revision:5684; number_of_response:1; }","duration":"505.940192ms","start":"2026-04-20T04:54:32.300798Z","end":"2026-04-20T04:54:32.806738Z","steps":["trace[1895875139] 'process raft request' (duration: 505.746325ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.807002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T04:54:32.300773Z","time spent":"506.125649ms","remote":"127.0.0.1:50590","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T04:54:32.807009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.974463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-04-20T04:54:32.807092Z","caller":"traceutil/trace.go:171","msg":"trace[141074480] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5684; }","duration":"299.098417ms","start":"2026-04-20T04:54:32.50797Z","end":"2026-04-20T04:54:32.807069Z","steps":["trace[141074480] 'agreement among raft nodes before linearized reading' (duration: 298.844657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.807091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.860682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T04:54:32.807166Z","caller":"traceutil/trace.go:171","msg":"trace[1653228613] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5684; }","duration":"121.971906ms","start":"2026-04-20T04:54:32.685175Z","end":"2026-04-20T04:54:32.807147Z","steps":["trace[1653228613] 'agreement among raft nodes before linearized reading' (duration: 121.830791ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.807258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.945043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-04-20T04:54:32.807318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.064232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-20T04:54:32.807371Z","caller":"traceutil/trace.go:171","msg":"trace[1722902699] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5684; }","duration":"287.176926ms","start":"2026-04-20T04:54:32.520178Z","end":"2026-04-20T04:54:32.807355Z","steps":["trace[1722902699] 'agreement among raft nodes before linearized reading' (duration: 286.711789ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:54:32.807369Z","caller":"traceutil/trace.go:171","msg":"trace[1507678090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5684; }","duration":"285.11973ms","start":"2026-04-20T04:54:32.522228Z","end":"2026-04-20T04:54:32.807347Z","steps":["trace[1507678090] 'agreement among raft nodes before linearized reading' (duration: 284.808148ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.807393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.15286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-20T04:54:32.807486Z","caller":"traceutil/trace.go:171","msg":"trace[125723397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5684; }","duration":"285.299026ms","start":"2026-04-20T04:54:32.522172Z","end":"2026-04-20T04:54:32.807471Z","steps":["trace[125723397] 'agreement among raft nodes before linearized reading' (duration: 284.930333ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T04:54:32.807948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.625207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.235\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-04-20T04:54:32.808015Z","caller":"traceutil/trace.go:171","msg":"trace[1465715551] range","detail":"{range_begin:/registry/masterleases/199.204.45.235; range_end:; response_count:1; response_revision:5684; }","duration":"175.69106ms","start":"2026-04-20T04:54:32.632307Z","end":"2026-04-20T04:54:32.807998Z","steps":["trace[1465715551] 'agreement among raft nodes before linearized reading' (duration: 174.649171ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T04:59:29.744599Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5673} {"level":"info","ts":"2026-04-20T04:59:29.820587Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5673,"took":"74.668161ms","hash":798632107,"current-db-size-bytes":53694464,"current-db-size":"54 MB","current-db-size-in-use-bytes":18440192,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T04:59:29.820643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":798632107,"revision":5673,"compact-revision":2937}