{"level":"warn","ts":"2026-04-28T17:24:16.986827Z","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-28T17:24:16.986971Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.125:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.125:2380","--initial-cluster=instance=https://199.19.213.125:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.125:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.125: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-28T17:24:16.987083Z","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-28T17:24:16.987102Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-04-28T17:24:16.987127Z","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-28T17:24:16.987987Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"]} {"level":"info","ts":"2026-04-28T17:24:16.988094Z","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":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.125: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-28T17:24:16.992464Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.05361ms"} {"level":"info","ts":"2026-04-28T17:24:17.004397Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b448fdce642f2755","cluster-id":"66f7e5dc9a72c5e3"} {"level":"info","ts":"2026-04-28T17:24:17.004551Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=()"} {"level":"info","ts":"2026-04-28T17:24:17.00458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 0"} {"level":"info","ts":"2026-04-28T17:24:17.0046Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b448fdce642f2755 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-28T17:24:17.00461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 1"} {"level":"info","ts":"2026-04-28T17:24:17.004668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"warn","ts":"2026-04-28T17:24:17.013948Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-28T17:24:17.160003Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-28T17:24:17.163321Z","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-28T17:24:17.16651Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b448fdce642f2755","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-28T17:24:17.166968Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b448fdce642f2755","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-28T17:24:17.167042Z","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-28T17:24:17.167158Z","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-28T17:24:17.16717Z","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-28T17:24:17.170268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"info","ts":"2026-04-28T17:24:17.170487Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","added-peer-id":"b448fdce642f2755","added-peer-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-04-28T17:24:17.172348Z","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-28T17:24:17.172502Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-04-28T17:24:17.172616Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-04-28T17:24:17.172619Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b448fdce642f2755","initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-28T17:24:17.172657Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-28T17:24:17.405163Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 is starting a new election at term 1"} {"level":"info","ts":"2026-04-28T17:24:17.405241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-28T17:24:17.405266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgPreVoteResp from b448fdce642f2755 at term 1"} {"level":"info","ts":"2026-04-28T17:24:17.405289Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became candidate at term 2"} {"level":"info","ts":"2026-04-28T17:24:17.405306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgVoteResp from b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-04-28T17:24:17.405335Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became leader at term 2"} {"level":"info","ts":"2026-04-28T17:24:17.405361Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b448fdce642f2755 elected leader b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-04-28T17:24:17.421071Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b448fdce642f2755","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.125:2379]}","request-path":"/0/members/b448fdce642f2755/attributes","cluster-id":"66f7e5dc9a72c5e3","publish-timeout":"7s"} {"level":"info","ts":"2026-04-28T17:24:17.421122Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T17:24:17.42116Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T17:24:17.421244Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-28T17:24:17.42136Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-28T17:24:17.421427Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-28T17:24:17.425104Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.125:2379"} {"level":"info","ts":"2026-04-28T17:24:17.425668Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T17:24:17.42586Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T17:24:17.425927Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-28T17:24:17.426476Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-28T17:24:48.063058Z","caller":"traceutil/trace.go:171","msg":"trace[1326849676] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"151.520377ms","start":"2026-04-28T17:24:47.911505Z","end":"2026-04-28T17:24:48.063025Z","steps":["trace[1326849676] 'process raft request' (duration: 151.301822ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431072Z","caller":"traceutil/trace.go:171","msg":"trace[26116297] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"517.484433ms","start":"2026-04-28T17:24:47.913557Z","end":"2026-04-28T17:24:48.431041Z","steps":["trace[26116297] 'process raft request' (duration: 517.267399ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431248Z","caller":"traceutil/trace.go:171","msg":"trace[1529096391] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"504.23181ms","start":"2026-04-28T17:24:47.926996Z","end":"2026-04-28T17:24:48.431228Z","steps":["trace[1529096391] 'process raft request' (duration: 504.051787ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431326Z","caller":"traceutil/trace.go:171","msg":"trace[1705421182] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"499.975946ms","start":"2026-04-28T17:24:47.931337Z","end":"2026-04-28T17:24:48.431313Z","steps":["trace[1705421182] 'process raft request' (duration: 499.864664ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.43138Z","caller":"traceutil/trace.go:171","msg":"trace[887784532] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"500.063779ms","start":"2026-04-28T17:24:47.931245Z","end":"2026-04-28T17:24:48.431308Z","steps":["trace[887784532] 'process raft request' (duration: 499.896265ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431437Z","caller":"traceutil/trace.go:171","msg":"trace[1664657280] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"500.226922ms","start":"2026-04-28T17:24:47.931155Z","end":"2026-04-28T17:24:48.431382Z","steps":["trace[1664657280] 'process raft request' (duration: 499.933706ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431662Z","caller":"traceutil/trace.go:171","msg":"trace[53864700] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"482.145894ms","start":"2026-04-28T17:24:47.949498Z","end":"2026-04-28T17:24:48.431644Z","steps":["trace[53864700] 'process raft request' (duration: 481.797717ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431683Z","caller":"traceutil/trace.go:171","msg":"trace[1066572662] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"477.582573ms","start":"2026-04-28T17:24:47.954077Z","end":"2026-04-28T17:24:48.43166Z","steps":["trace[1066572662] 'process raft request' (duration: 477.327508ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431682Z","caller":"traceutil/trace.go:171","msg":"trace[189755441] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"459.701839ms","start":"2026-04-28T17:24:47.971959Z","end":"2026-04-28T17:24:48.43166Z","steps":["trace[189755441] 'process raft request' (duration: 459.585217ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.431687Z","caller":"traceutil/trace.go:171","msg":"trace[968083746] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"491.366596ms","start":"2026-04-28T17:24:47.940265Z","end":"2026-04-28T17:24:48.431631Z","steps":["trace[968083746] 'process raft request' (duration: 490.982018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:24:48.431846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.940249Z","time spent":"491.513638ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.431841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.971919Z","time spent":"459.841102ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.43184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.931122Z","time spent":"500.401475ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.431915Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.931331Z","time spent":"500.023457ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.431959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.949487Z","time spent":"482.231686ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.432021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.931239Z","time spent":"500.274363ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.432045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.954046Z","time spent":"477.676135ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.43206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.92697Z","time spent":"504.316422ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.432137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.913503Z","time spent":"517.655177ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T17:24:48.432101Z","caller":"traceutil/trace.go:171","msg":"trace[2076218718] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"518.942771ms","start":"2026-04-28T17:24:47.913132Z","end":"2026-04-28T17:24:48.432075Z","steps":["trace[2076218718] 'process raft request' (duration: 517.8397ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:24:48.432212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:47.913115Z","time spent":"519.064174ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T17:24:48.437365Z","caller":"traceutil/trace.go:171","msg":"trace[1064615083] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"366.552127ms","start":"2026-04-28T17:24:48.070789Z","end":"2026-04-28T17:24:48.437341Z","steps":["trace[1064615083] 'process raft request' (duration: 366.374784ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:24:48.437477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:48.070762Z","time spent":"366.66428ms","remote":"127.0.0.1:53144","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":995,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T17:24:48.437512Z","caller":"traceutil/trace.go:171","msg":"trace[451957555] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"365.737161ms","start":"2026-04-28T17:24:48.071755Z","end":"2026-04-28T17:24:48.437492Z","steps":["trace[451957555] 'process raft request' (duration: 365.523067ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.437512Z","caller":"traceutil/trace.go:171","msg":"trace[1672573190] transaction","detail":"{read_only:false; number_of_response:1; response_revision:482; }","duration":"365.319483ms","start":"2026-04-28T17:24:48.07217Z","end":"2026-04-28T17:24:48.43749Z","steps":["trace[1672573190] 'process raft request' (duration: 365.177291ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:24:48.437867Z","caller":"traceutil/trace.go:171","msg":"trace[1665361540] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"359.689452ms","start":"2026-04-28T17:24:48.078158Z","end":"2026-04-28T17:24:48.437848Z","steps":["trace[1665361540] 'process raft request' (duration: 359.256254ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:24:48.437953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:48.078144Z","time spent":"359.770564ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-28T17:24:48.438027Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:48.071734Z","time spent":"365.809602ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7317,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T17:24:48.438118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:48.07214Z","time spent":"365.417325ms","remote":"127.0.0.1:52684","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7366,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T17:24:55.234487Z","caller":"traceutil/trace.go:171","msg":"trace[808162181] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"403.349395ms","start":"2026-04-28T17:24:54.831087Z","end":"2026-04-28T17:24:55.234437Z","steps":["trace[808162181] 'process raft request' (duration: 380.711985ms)","trace[808162181] 'compare' (duration: 22.241172ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:24:55.234771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:54.83106Z","time spent":"403.57801ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T17:24:55.245514Z","caller":"traceutil/trace.go:171","msg":"trace[723175782] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"413.862658ms","start":"2026-04-28T17:24:54.831624Z","end":"2026-04-28T17:24:55.245486Z","steps":["trace[723175782] 'process raft request' (duration: 413.721125ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:24:55.245666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:24:54.831599Z","time spent":"413.994191ms","remote":"127.0.0.1:52868","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T17:25:09.724414Z","caller":"traceutil/trace.go:171","msg":"trace[1726892805] transaction","detail":"{read_only:false; response_revision:739; number_of_response:1; }","duration":"176.104278ms","start":"2026-04-28T17:25:09.548284Z","end":"2026-04-28T17:25:09.724388Z","steps":["trace[1726892805] 'process raft request' (duration: 175.937295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:25:36.785686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.140279ms","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-28T17:25:36.785913Z","caller":"traceutil/trace.go:171","msg":"trace[281095700] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1134; }","duration":"142.437925ms","start":"2026-04-28T17:25:36.643443Z","end":"2026-04-28T17:25:36.785881Z","steps":["trace[281095700] 'range keys from in-memory index tree' (duration: 141.818382ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:26:22.683726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.665315ms","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":"info","ts":"2026-04-28T17:26:22.683848Z","caller":"traceutil/trace.go:171","msg":"trace[1677743561] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:1800; }","duration":"138.835918ms","start":"2026-04-28T17:26:22.544992Z","end":"2026-04-28T17:26:22.683828Z","steps":["trace[1677743561] 'range keys from in-memory index tree' (duration: 138.492992ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:26:22.71395Z","caller":"traceutil/trace.go:171","msg":"trace[1162934615] transaction","detail":"{read_only:false; response_revision:1801; number_of_response:1; }","duration":"163.13054ms","start":"2026-04-28T17:26:22.550793Z","end":"2026-04-28T17:26:22.713924Z","steps":["trace[1162934615] 'process raft request' (duration: 162.945026ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:26:23.151604Z","caller":"traceutil/trace.go:171","msg":"trace[181494702] transaction","detail":"{read_only:false; response_revision:1805; number_of_response:1; }","duration":"115.795392ms","start":"2026-04-28T17:26:23.035775Z","end":"2026-04-28T17:26:23.15157Z","steps":["trace[181494702] 'process raft request' (duration: 79.658847ms)","trace[181494702] 'compare' (duration: 35.933571ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:27:11.981082Z","caller":"traceutil/trace.go:171","msg":"trace[1278094575] transaction","detail":"{read_only:false; response_revision:2116; number_of_response:1; }","duration":"103.865447ms","start":"2026-04-28T17:27:11.877174Z","end":"2026-04-28T17:27:11.981039Z","steps":["trace[1278094575] 'process raft request' (duration: 103.563322ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:27:12.178007Z","caller":"traceutil/trace.go:171","msg":"trace[889163114] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"192.494765ms","start":"2026-04-28T17:27:11.985481Z","end":"2026-04-28T17:27:12.177976Z","steps":["trace[889163114] 'process raft request' (duration: 191.023316ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:27:12.17826Z","caller":"traceutil/trace.go:171","msg":"trace[914631590] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"192.72533ms","start":"2026-04-28T17:27:11.985515Z","end":"2026-04-28T17:27:12.17824Z","steps":["trace[914631590] 'process raft request' (duration: 192.403433ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:27:52.490414Z","caller":"traceutil/trace.go:171","msg":"trace[678849968] transaction","detail":"{read_only:false; response_revision:2384; number_of_response:1; }","duration":"124.940212ms","start":"2026-04-28T17:27:52.365435Z","end":"2026-04-28T17:27:52.490375Z","steps":["trace[678849968] 'process raft request' (duration: 124.699188ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:27:52.492164Z","caller":"traceutil/trace.go:171","msg":"trace[808206392] transaction","detail":"{read_only:false; response_revision:2385; number_of_response:1; }","duration":"126.435113ms","start":"2026-04-28T17:27:52.365699Z","end":"2026-04-28T17:27:52.492134Z","steps":["trace[808206392] 'process raft request' (duration: 126.266149ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:32:22.09269Z","caller":"traceutil/trace.go:171","msg":"trace[2142551342] linearizableReadLoop","detail":"{readStateIndex:4772; appliedIndex:4770; }","duration":"133.749316ms","start":"2026-04-28T17:32:21.958909Z","end":"2026-04-28T17:32:22.092658Z","steps":["trace[2142551342] 'read index received' (duration: 4.968558ms)","trace[2142551342] 'applied index is now lower than readState.Index' (duration: 128.778497ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:32:22.092807Z","caller":"traceutil/trace.go:171","msg":"trace[1063076919] transaction","detail":"{read_only:false; response_revision:4598; number_of_response:1; }","duration":"135.329146ms","start":"2026-04-28T17:32:21.957437Z","end":"2026-04-28T17:32:22.092766Z","steps":["trace[1063076919] 'process raft request' (duration: 75.66335ms)","trace[1063076919] 'compare' (duration: 59.430751ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:32:22.09297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.031841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-28T17:32:22.093045Z","caller":"traceutil/trace.go:171","msg":"trace[1682650529] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4598; }","duration":"134.122873ms","start":"2026-04-28T17:32:21.958905Z","end":"2026-04-28T17:32:22.093028Z","steps":["trace[1682650529] 'agreement among raft nodes before linearized reading' (duration: 133.870488ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:32:22.093164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.146264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-04-28T17:32:22.093205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.240407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:9 size:75467"} {"level":"info","ts":"2026-04-28T17:32:22.093233Z","caller":"traceutil/trace.go:171","msg":"trace[1147388338] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4598; }","duration":"100.272136ms","start":"2026-04-28T17:32:21.992941Z","end":"2026-04-28T17:32:22.093214Z","steps":["trace[1147388338] 'agreement among raft nodes before linearized reading' (duration: 100.118253ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:32:22.093256Z","caller":"traceutil/trace.go:171","msg":"trace[1787518199] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:9; response_revision:4598; }","duration":"131.323638ms","start":"2026-04-28T17:32:21.96192Z","end":"2026-04-28T17:32:22.093243Z","steps":["trace[1787518199] 'agreement among raft nodes before linearized reading' (duration: 130.954281ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:32:26.996588Z","caller":"traceutil/trace.go:171","msg":"trace[480254138] transaction","detail":"{read_only:false; response_revision:4756; number_of_response:1; }","duration":"179.228872ms","start":"2026-04-28T17:32:26.817337Z","end":"2026-04-28T17:32:26.996566Z","steps":["trace[480254138] 'process raft request' (duration: 178.892314ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:32:45.027767Z","caller":"traceutil/trace.go:171","msg":"trace[1583412377] transaction","detail":"{read_only:false; response_revision:5098; number_of_response:1; }","duration":"187.81491ms","start":"2026-04-28T17:32:44.839907Z","end":"2026-04-28T17:32:45.027722Z","steps":["trace[1583412377] 'process raft request' (duration: 187.586906ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:34:17.610056Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2844} {"level":"info","ts":"2026-04-28T17:34:17.675593Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2844,"took":"64.17912ms","hash":1511014009,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":33550336,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-28T17:34:17.675662Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1511014009,"revision":2844,"compact-revision":-1} {"level":"info","ts":"2026-04-28T17:38:38.354421Z","caller":"traceutil/trace.go:171","msg":"trace[1241767899] transaction","detail":"{read_only:false; response_revision:7897; number_of_response:1; }","duration":"111.890361ms","start":"2026-04-28T17:38:38.242505Z","end":"2026-04-28T17:38:38.354395Z","steps":["trace[1241767899] 'process raft request' (duration: 111.726208ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:38:49.776595Z","caller":"traceutil/trace.go:171","msg":"trace[1492199039] transaction","detail":"{read_only:false; response_revision:7955; number_of_response:1; }","duration":"291.250887ms","start":"2026-04-28T17:38:49.485308Z","end":"2026-04-28T17:38:49.776559Z","steps":["trace[1492199039] 'process raft request' (duration: 290.986191ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:38:50.537325Z","caller":"traceutil/trace.go:171","msg":"trace[215649201] transaction","detail":"{read_only:false; response_revision:7959; number_of_response:1; }","duration":"123.589309ms","start":"2026-04-28T17:38:50.413711Z","end":"2026-04-28T17:38:50.537301Z","steps":["trace[215649201] 'process raft request' (duration: 123.410555ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:39:17.616013Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5991} {"level":"warn","ts":"2026-04-28T17:39:17.880091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.910116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T17:39:17.880166Z","caller":"traceutil/trace.go:171","msg":"trace[2117018109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8160; }","duration":"118.027238ms","start":"2026-04-28T17:39:17.762122Z","end":"2026-04-28T17:39:17.880149Z","steps":["trace[2117018109] 'range keys from in-memory index tree' (duration: 117.836665ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:39:18.026553Z","caller":"traceutil/trace.go:171","msg":"trace[1337670657] transaction","detail":"{read_only:false; response_revision:8161; number_of_response:1; }","duration":"157.719347ms","start":"2026-04-28T17:39:17.868798Z","end":"2026-04-28T17:39:18.026517Z","steps":["trace[1337670657] 'process raft request' (duration: 65.132765ms)","trace[1337670657] 'compare' (duration: 92.44083ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:39:18.118061Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5991,"took":"500.257002ms","hash":565370729,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":22450176,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-04-28T17:39:18.11814Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":565370729,"revision":5991,"compact-revision":2844} {"level":"info","ts":"2026-04-28T17:39:31.514705Z","caller":"traceutil/trace.go:171","msg":"trace[224775355] transaction","detail":"{read_only:false; response_revision:8274; number_of_response:1; }","duration":"167.762678ms","start":"2026-04-28T17:39:31.346917Z","end":"2026-04-28T17:39:31.51468Z","steps":["trace[224775355] 'process raft request' (duration: 167.555054ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:39:32.278041Z","caller":"traceutil/trace.go:171","msg":"trace[389395138] linearizableReadLoop","detail":"{readStateIndex:8571; appliedIndex:8570; }","duration":"151.693748ms","start":"2026-04-28T17:39:32.126274Z","end":"2026-04-28T17:39:32.277968Z","steps":["trace[389395138] 'read index received' (duration: 151.560705ms)","trace[389395138] 'applied index is now lower than readState.Index' (duration: 132.483µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:39:32.278076Z","caller":"traceutil/trace.go:171","msg":"trace[1290311430] transaction","detail":"{read_only:false; response_revision:8281; number_of_response:1; }","duration":"176.831638ms","start":"2026-04-28T17:39:32.101224Z","end":"2026-04-28T17:39:32.278056Z","steps":["trace[1290311430] 'process raft request' (duration: 176.620474ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:39:32.278386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.077275ms","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-28T17:39:32.2785Z","caller":"traceutil/trace.go:171","msg":"trace[1048690533] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8281; }","duration":"152.230608ms","start":"2026-04-28T17:39:32.126245Z","end":"2026-04-28T17:39:32.278476Z","steps":["trace[1048690533] 'agreement among raft nodes before linearized reading' (duration: 151.886411ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:39:32.384341Z","caller":"traceutil/trace.go:171","msg":"trace[1957960621] transaction","detail":"{read_only:false; response_revision:8282; number_of_response:1; }","duration":"205.581081ms","start":"2026-04-28T17:39:32.178716Z","end":"2026-04-28T17:39:32.384297Z","steps":["trace[1957960621] 'process raft request' (duration: 154.226348ms)","trace[1957960621] 'compare' (duration: 51.163009ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:39:32.384446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.746072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-28T17:39:32.384519Z","caller":"traceutil/trace.go:171","msg":"trace[1110835820] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:8283; }","duration":"120.875405ms","start":"2026-04-28T17:39:32.263628Z","end":"2026-04-28T17:39:32.384504Z","steps":["trace[1110835820] 'agreement among raft nodes before linearized reading' (duration: 120.721862ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:39:32.38436Z","caller":"traceutil/trace.go:171","msg":"trace[78563518] linearizableReadLoop","detail":"{readStateIndex:8572; appliedIndex:8571; }","duration":"106.169902ms","start":"2026-04-28T17:39:32.278156Z","end":"2026-04-28T17:39:32.384326Z","steps":["trace[78563518] 'read index received' (duration: 54.80651ms)","trace[78563518] 'applied index is now lower than readState.Index' (duration: 51.358942ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:39:32.384588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.984253ms","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-04-28T17:39:32.38468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"255.505563ms","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-28T17:39:32.384728Z","caller":"traceutil/trace.go:171","msg":"trace[824677327] transaction","detail":"{read_only:false; response_revision:8283; number_of_response:1; }","duration":"102.215185ms","start":"2026-04-28T17:39:32.28208Z","end":"2026-04-28T17:39:32.384295Z","steps":["trace[824677327] 'process raft request' (duration: 102.155134ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:39:32.384691Z","caller":"traceutil/trace.go:171","msg":"trace[1521108226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8283; }","duration":"169.168586ms","start":"2026-04-28T17:39:32.215503Z","end":"2026-04-28T17:39:32.384671Z","steps":["trace[1521108226] 'agreement among raft nodes before linearized reading' (duration: 168.889071ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:39:32.384904Z","caller":"traceutil/trace.go:171","msg":"trace[287685183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8283; }","duration":"255.720928ms","start":"2026-04-28T17:39:32.129077Z","end":"2026-04-28T17:39:32.384798Z","steps":["trace[287685183] 'agreement among raft nodes before linearized reading' (duration: 255.3401ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:40:39.842995Z","caller":"traceutil/trace.go:171","msg":"trace[1606297706] transaction","detail":"{read_only:false; response_revision:8913; number_of_response:1; }","duration":"148.730479ms","start":"2026-04-28T17:40:39.694187Z","end":"2026-04-28T17:40:39.842918Z","steps":["trace[1606297706] 'process raft request' (duration: 148.471574ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:40:39.908754Z","caller":"traceutil/trace.go:171","msg":"trace[1585169865] transaction","detail":"{read_only:false; response_revision:8914; number_of_response:1; }","duration":"100.54539ms","start":"2026-04-28T17:40:39.808181Z","end":"2026-04-28T17:40:39.908726Z","steps":["trace[1585169865] 'process raft request' (duration: 100.110482ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:40:49.907577Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002468.wal"} {"level":"info","ts":"2026-04-28T17:42:10.786166Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-28T17:42:10.7926Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-28T17:42:10.792743Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-28T17:44:14.072369Z","caller":"traceutil/trace.go:171","msg":"trace[2030049287] transaction","detail":"{read_only:false; response_revision:10813; number_of_response:1; }","duration":"176.333938ms","start":"2026-04-28T17:44:13.895994Z","end":"2026-04-28T17:44:14.072327Z","steps":["trace[2030049287] 'process raft request' (duration: 161.146205ms)","trace[2030049287] 'compare' (duration: 14.885947ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:44:14.0808Z","caller":"traceutil/trace.go:171","msg":"trace[1913129070] transaction","detail":"{read_only:false; response_revision:10814; number_of_response:1; }","duration":"184.659035ms","start":"2026-04-28T17:44:13.896098Z","end":"2026-04-28T17:44:14.080757Z","steps":["trace[1913129070] 'process raft request' (duration: 184.3748ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:44:17.623211Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8160} {"level":"info","ts":"2026-04-28T17:44:17.678204Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8160,"took":"53.152694ms","hash":2804740569,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":30289920,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-28T17:44:17.678254Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2804740569,"revision":8160,"compact-revision":5991} {"level":"info","ts":"2026-04-28T17:44:30.737363Z","caller":"traceutil/trace.go:171","msg":"trace[75082320] linearizableReadLoop","detail":"{readStateIndex:11314; appliedIndex:11313; }","duration":"371.612477ms","start":"2026-04-28T17:44:30.365722Z","end":"2026-04-28T17:44:30.737334Z","steps":["trace[75082320] 'read index received' (duration: 371.430464ms)","trace[75082320] 'applied index is now lower than readState.Index' (duration: 180.693µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:44:30.737419Z","caller":"traceutil/trace.go:171","msg":"trace[1491501802] transaction","detail":"{read_only:false; response_revision:10947; number_of_response:1; }","duration":"383.164988ms","start":"2026-04-28T17:44:30.354219Z","end":"2026-04-28T17:44:30.737384Z","steps":["trace[1491501802] 'process raft request' (duration: 382.922323ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:44:30.737588Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:44:30.354191Z","time spent":"383.303871ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T17:44:30.737629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.000684ms","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-28T17:44:30.737673Z","caller":"traceutil/trace.go:171","msg":"trace[2143342412] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:10947; }","duration":"278.100757ms","start":"2026-04-28T17:44:30.459555Z","end":"2026-04-28T17:44:30.737656Z","steps":["trace[2143342412] 'agreement among raft nodes before linearized reading' (duration: 277.946834ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:44:30.737741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.938683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-28T17:44:30.737857Z","caller":"traceutil/trace.go:171","msg":"trace[1844530908] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:10947; }","duration":"372.160869ms","start":"2026-04-28T17:44:30.365668Z","end":"2026-04-28T17:44:30.737829Z","steps":["trace[1844530908] 'agreement among raft nodes before linearized reading' (duration: 371.805531ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:44:30.737923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:44:30.36565Z","time spent":"372.257372ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":582,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-04-28T17:49:17.632792Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10835} {"level":"info","ts":"2026-04-28T17:49:17.71447Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10835,"took":"79.108434ms","hash":1474079271,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":27361280,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-04-28T17:49:17.71466Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1474079271,"revision":10835,"compact-revision":8160} {"level":"info","ts":"2026-04-28T17:50:03.157995Z","caller":"traceutil/trace.go:171","msg":"trace[2086953070] transaction","detail":"{read_only:false; response_revision:13203; number_of_response:1; }","duration":"134.124103ms","start":"2026-04-28T17:50:03.023844Z","end":"2026-04-28T17:50:03.157968Z","steps":["trace[2086953070] 'process raft request' (duration: 133.97397ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:50:21.750505Z","caller":"traceutil/trace.go:171","msg":"trace[1117309549] linearizableReadLoop","detail":"{readStateIndex:13752; appliedIndex:13751; }","duration":"131.838736ms","start":"2026-04-28T17:50:21.618641Z","end":"2026-04-28T17:50:21.75048Z","steps":["trace[1117309549] 'read index received' (duration: 131.54265ms)","trace[1117309549] 'applied index is now lower than readState.Index' (duration: 294.996µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:50:21.750568Z","caller":"traceutil/trace.go:171","msg":"trace[1780467936] transaction","detail":"{read_only:false; response_revision:13302; number_of_response:1; }","duration":"138.135993ms","start":"2026-04-28T17:50:21.612409Z","end":"2026-04-28T17:50:21.750545Z","steps":["trace[1780467936] 'process raft request' (duration: 137.856017ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:50:21.750959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.300355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-9xhs7\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-04-28T17:50:21.751019Z","caller":"traceutil/trace.go:171","msg":"trace[412364419] range","detail":"{range_begin:/registry/pods/openstack/keepalived-9xhs7; range_end:; response_count:1; response_revision:13302; }","duration":"132.402548ms","start":"2026-04-28T17:50:21.618601Z","end":"2026-04-28T17:50:21.751004Z","steps":["trace[412364419] 'agreement among raft nodes before linearized reading' (duration: 132.01962ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:52:26.653886Z","caller":"traceutil/trace.go:171","msg":"trace[449949042] linearizableReadLoop","detail":"{readStateIndex:15009; appliedIndex:15008; }","duration":"119.302104ms","start":"2026-04-28T17:52:26.534546Z","end":"2026-04-28T17:52:26.653848Z","steps":["trace[449949042] 'read index received' (duration: 78.261987ms)","trace[449949042] 'applied index is now lower than readState.Index' (duration: 41.038627ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:52:26.654112Z","caller":"traceutil/trace.go:171","msg":"trace[469239420] transaction","detail":"{read_only:false; response_revision:14518; number_of_response:1; }","duration":"129.694514ms","start":"2026-04-28T17:52:26.524373Z","end":"2026-04-28T17:52:26.654068Z","steps":["trace[469239420] 'process raft request' (duration: 88.489943ms)","trace[469239420] 'compare' (duration: 40.804883ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:52:26.654276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.702412ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-28T17:52:26.654386Z","caller":"traceutil/trace.go:171","msg":"trace[1612656397] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:14518; }","duration":"119.859146ms","start":"2026-04-28T17:52:26.5345Z","end":"2026-04-28T17:52:26.654359Z","steps":["trace[1612656397] 'agreement among raft nodes before linearized reading' (duration: 119.58995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:52:26.654439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.519437ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-04-28T17:52:26.654522Z","caller":"traceutil/trace.go:171","msg":"trace[1239955703] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14518; }","duration":"109.613559ms","start":"2026-04-28T17:52:26.544893Z","end":"2026-04-28T17:52:26.654507Z","steps":["trace[1239955703] 'agreement among raft nodes before linearized reading' (duration: 109.420975ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:54:17.641493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12885} {"level":"info","ts":"2026-04-28T17:54:17.715934Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12885,"took":"71.562285ms","hash":2966241460,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":30748672,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-28T17:54:17.71601Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2966241460,"revision":12885,"compact-revision":10835} {"level":"warn","ts":"2026-04-28T17:54:25.233247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.713413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-04-28T17:54:25.233401Z","caller":"traceutil/trace.go:171","msg":"trace[2110408043] transaction","detail":"{read_only:false; response_revision:15395; number_of_response:1; }","duration":"413.954867ms","start":"2026-04-28T17:54:24.819401Z","end":"2026-04-28T17:54:25.233356Z","steps":["trace[2110408043] 'compare' (duration: 412.615251ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:54:25.233484Z","caller":"traceutil/trace.go:171","msg":"trace[1104873856] linearizableReadLoop","detail":"{readStateIndex:15917; appliedIndex:15916; }","duration":"408.900767ms","start":"2026-04-28T17:54:24.824576Z","end":"2026-04-28T17:54:25.233477Z","steps":["trace[1104873856] 'read index received' (duration: 23.511µs)","trace[1104873856] 'applied index is now lower than readState.Index' (duration: 408.876386ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:54:25.233582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:54:24.819389Z","time spent":"414.1178ms","remote":"127.0.0.1:52952","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":795,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-28T17:54:25.233421Z","caller":"traceutil/trace.go:171","msg":"trace[1563573015] transaction","detail":"{read_only:false; response_revision:15396; number_of_response:1; }","duration":"352.892581ms","start":"2026-04-28T17:54:24.880515Z","end":"2026-04-28T17:54:25.233407Z","steps":["trace[1563573015] 'process raft request' (duration: 352.83206ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:54:25.233811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.207283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-04-28T17:54:25.233897Z","caller":"traceutil/trace.go:171","msg":"trace[1426576016] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:15396; }","duration":"409.319844ms","start":"2026-04-28T17:54:24.824558Z","end":"2026-04-28T17:54:25.233878Z","steps":["trace[1426576016] 'agreement among raft nodes before linearized reading' (duration: 409.052639ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:54:25.233939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:54:24.824551Z","time spent":"409.377255ms","remote":"127.0.0.1:52822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":1308,"request content":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" "} {"level":"warn","ts":"2026-04-28T17:54:25.233804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T17:54:24.880491Z","time spent":"353.173306ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T17:54:25.234402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.446923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-xz44f\" ","response":"range_response_count:1 size:22131"} {"level":"warn","ts":"2026-04-28T17:54:25.234444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.488556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-28T17:54:25.234472Z","caller":"traceutil/trace.go:171","msg":"trace[666144217] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-xz44f; range_end:; response_count:1; response_revision:15397; }","duration":"209.515545ms","start":"2026-04-28T17:54:25.024941Z","end":"2026-04-28T17:54:25.234457Z","steps":["trace[666144217] 'agreement among raft nodes before linearized reading' (duration: 209.299761ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:54:25.234476Z","caller":"traceutil/trace.go:171","msg":"trace[901489893] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:15397; }","duration":"172.565438ms","start":"2026-04-28T17:54:25.061899Z","end":"2026-04-28T17:54:25.234465Z","steps":["trace[901489893] 'agreement among raft nodes before linearized reading' (duration: 172.459316ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:54:25.234509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.228543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-28T17:54:25.234553Z","caller":"traceutil/trace.go:171","msg":"trace[471293167] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:15397; }","duration":"130.313635ms","start":"2026-04-28T17:54:25.104225Z","end":"2026-04-28T17:54:25.234539Z","steps":["trace[471293167] 'agreement among raft nodes before linearized reading' (duration: 130.231584ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:54:25.234549Z","caller":"traceutil/trace.go:171","msg":"trace[1135248253] transaction","detail":"{read_only:false; response_revision:15397; number_of_response:1; }","duration":"173.593228ms","start":"2026-04-28T17:54:25.060941Z","end":"2026-04-28T17:54:25.234534Z","steps":["trace[1135248253] 'process raft request' (duration: 173.19414ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:54:25.234797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.334162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-dgr2t\" ","response":"range_response_count:1 size:9799"} {"level":"info","ts":"2026-04-28T17:54:25.234881Z","caller":"traceutil/trace.go:171","msg":"trace[728651610] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-dgr2t; range_end:; response_count:1; response_revision:15397; }","duration":"191.469245ms","start":"2026-04-28T17:54:25.043389Z","end":"2026-04-28T17:54:25.234858Z","steps":["trace[728651610] 'agreement among raft nodes before linearized reading' (duration: 191.191279ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:54:25.235213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.452264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2366191"} {"level":"info","ts":"2026-04-28T17:54:25.235276Z","caller":"traceutil/trace.go:171","msg":"trace[1994152760] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:15397; }","duration":"188.572476ms","start":"2026-04-28T17:54:25.046691Z","end":"2026-04-28T17:54:25.235264Z","steps":["trace[1994152760] 'agreement among raft nodes before linearized reading' (duration: 187.841752ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:57:28.803032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.310288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"info","ts":"2026-04-28T17:57:28.803131Z","caller":"traceutil/trace.go:171","msg":"trace[1762210215] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:16864; }","duration":"104.505992ms","start":"2026-04-28T17:57:28.698603Z","end":"2026-04-28T17:57:28.803109Z","steps":["trace[1762210215] 'range keys from in-memory index tree' (duration: 104.102044ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T17:57:28.803427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.186957ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-28T17:57:28.803487Z","caller":"traceutil/trace.go:171","msg":"trace[1331615288] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:16864; }","duration":"104.296389ms","start":"2026-04-28T17:57:28.699175Z","end":"2026-04-28T17:57:28.803471Z","steps":["trace[1331615288] 'range keys from in-memory index tree' (duration: 104.057164ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:57:29.136649Z","caller":"traceutil/trace.go:171","msg":"trace[2129852329] linearizableReadLoop","detail":"{readStateIndex:17434; appliedIndex:17433; }","duration":"227.601435ms","start":"2026-04-28T17:57:28.909022Z","end":"2026-04-28T17:57:29.136623Z","steps":["trace[2129852329] 'read index received' (duration: 214.120386ms)","trace[2129852329] 'applied index is now lower than readState.Index' (duration: 13.477029ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:57:29.137173Z","caller":"traceutil/trace.go:171","msg":"trace[116504671] transaction","detail":"{read_only:false; response_revision:16867; number_of_response:1; }","duration":"230.072533ms","start":"2026-04-28T17:57:28.907074Z","end":"2026-04-28T17:57:29.137146Z","steps":["trace[116504671] 'process raft request' (duration: 216.056094ms)","trace[116504671] 'compare' (duration: 13.026279ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:57:29.138631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.436591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-28T17:57:29.138699Z","caller":"traceutil/trace.go:171","msg":"trace[1818319683] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:16867; }","duration":"229.677595ms","start":"2026-04-28T17:57:28.908998Z","end":"2026-04-28T17:57:29.138675Z","steps":["trace[1818319683] 'agreement among raft nodes before linearized reading' (duration: 227.779228ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:57:29.313225Z","caller":"traceutil/trace.go:171","msg":"trace[1224235686] linearizableReadLoop","detail":"{readStateIndex:17436; appliedIndex:17435; }","duration":"123.826458ms","start":"2026-04-28T17:57:29.189366Z","end":"2026-04-28T17:57:29.313193Z","steps":["trace[1224235686] 'read index received' (duration: 52.346923ms)","trace[1224235686] 'applied index is now lower than readState.Index' (duration: 71.478315ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T17:57:29.313389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.016691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-28T17:57:29.313364Z","caller":"traceutil/trace.go:171","msg":"trace[671025383] transaction","detail":"{read_only:false; response_revision:16869; number_of_response:1; }","duration":"155.988908ms","start":"2026-04-28T17:57:29.157334Z","end":"2026-04-28T17:57:29.313323Z","steps":["trace[671025383] 'process raft request' (duration: 84.432022ms)","trace[671025383] 'compare' (duration: 71.084896ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T17:57:29.313422Z","caller":"traceutil/trace.go:171","msg":"trace[632156912] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:16869; }","duration":"124.105453ms","start":"2026-04-28T17:57:29.189308Z","end":"2026-04-28T17:57:29.313414Z","steps":["trace[632156912] 'agreement among raft nodes before linearized reading' (duration: 124.031322ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T17:59:17.648042Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15329} {"level":"info","ts":"2026-04-28T17:59:17.744378Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15329,"took":"92.380533ms","hash":1251811850,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":33181696,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-28T17:59:17.744476Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1251811850,"revision":15329,"compact-revision":12885} {"level":"info","ts":"2026-04-28T18:01:56.300498Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-28T18:01:56.305453Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-04-28T18:01:56.305531Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-04-28T18:04:17.653844Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17933} {"level":"info","ts":"2026-04-28T18:04:17.764704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17933,"took":"106.956314ms","hash":1868345203,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":31522816,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-28T18:04:17.764778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1868345203,"revision":17933,"compact-revision":15329} {"level":"warn","ts":"2026-04-28T18:04:51.108134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.687788ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:04:51.108333Z","caller":"traceutil/trace.go:171","msg":"trace[1735188277] transaction","detail":"{read_only:false; response_revision:20589; number_of_response:1; }","duration":"153.579985ms","start":"2026-04-28T18:04:50.954723Z","end":"2026-04-28T18:04:51.108303Z","steps":["trace[1735188277] 'process raft request' (duration: 35.55196ms)","trace[1735188277] 'compare' (duration: 117.286309ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:04:56.707062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.085144ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:04:56.707318Z","caller":"traceutil/trace.go:171","msg":"trace[1050184576] transaction","detail":"{read_only:false; response_revision:20616; number_of_response:1; }","duration":"268.61047ms","start":"2026-04-28T18:04:56.43865Z","end":"2026-04-28T18:04:56.707261Z","steps":["trace[1050184576] 'process raft request' (duration: 98.229221ms)","trace[1050184576] 'compare' (duration: 169.960251ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:04:56.707526Z","caller":"traceutil/trace.go:171","msg":"trace[1769337075] transaction","detail":"{read_only:false; response_revision:20617; number_of_response:1; }","duration":"266.541519ms","start":"2026-04-28T18:04:56.440939Z","end":"2026-04-28T18:04:56.70748Z","steps":["trace[1769337075] 'process raft request' (duration: 266.233693ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:04:56.70759Z","caller":"traceutil/trace.go:171","msg":"trace[159529741] transaction","detail":"{read_only:false; response_revision:20618; number_of_response:1; }","duration":"150.130985ms","start":"2026-04-28T18:04:56.557419Z","end":"2026-04-28T18:04:56.70755Z","steps":["trace[159529741] 'process raft request' (duration: 149.816799ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:04:57.461907Z","caller":"traceutil/trace.go:171","msg":"trace[946183982] linearizableReadLoop","detail":"{readStateIndex:21304; appliedIndex:21303; }","duration":"168.474011ms","start":"2026-04-28T18:04:57.293396Z","end":"2026-04-28T18:04:57.46187Z","steps":["trace[946183982] 'read index received' (duration: 168.347999ms)","trace[946183982] 'applied index is now lower than readState.Index' (duration: 124.212µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:04:57.462005Z","caller":"traceutil/trace.go:171","msg":"trace[1553105011] transaction","detail":"{read_only:false; response_revision:20620; number_of_response:1; }","duration":"203.376669ms","start":"2026-04-28T18:04:57.2586Z","end":"2026-04-28T18:04:57.461977Z","steps":["trace[1553105011] 'process raft request' (duration: 203.011662ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:04:57.462236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.757718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-28T18:04:57.462439Z","caller":"traceutil/trace.go:171","msg":"trace[115357797] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20620; }","duration":"169.030212ms","start":"2026-04-28T18:04:57.293352Z","end":"2026-04-28T18:04:57.462382Z","steps":["trace[115357797] 'agreement among raft nodes before linearized reading' (duration: 168.677425ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:04:57.740685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.913114ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:04:57.741034Z","caller":"traceutil/trace.go:171","msg":"trace[1281313607] transaction","detail":"{read_only:false; response_revision:20621; number_of_response:1; }","duration":"274.470167ms","start":"2026-04-28T18:04:57.466544Z","end":"2026-04-28T18:04:57.741015Z","steps":["trace[1281313607] 'process raft request' (duration: 168.163885ms)","trace[1281313607] 'compare' (duration: 105.841653ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:04:57.741191Z","caller":"traceutil/trace.go:171","msg":"trace[732623436] linearizableReadLoop","detail":"{readStateIndex:21305; appliedIndex:21304; }","duration":"205.216175ms","start":"2026-04-28T18:04:57.535936Z","end":"2026-04-28T18:04:57.741153Z","steps":["trace[732623436] 'read index received' (duration: 98.786231ms)","trace[732623436] 'applied index is now lower than readState.Index' (duration: 106.427884ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:04:57.741326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.397389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-28T18:04:57.74136Z","caller":"traceutil/trace.go:171","msg":"trace[1829344959] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20622; }","duration":"205.469529ms","start":"2026-04-28T18:04:57.535881Z","end":"2026-04-28T18:04:57.741351Z","steps":["trace[1829344959] 'agreement among raft nodes before linearized reading' (duration: 205.360187ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:04:57.741374Z","caller":"traceutil/trace.go:171","msg":"trace[1372774720] transaction","detail":"{read_only:false; response_revision:20622; number_of_response:1; }","duration":"182.876588ms","start":"2026-04-28T18:04:57.55847Z","end":"2026-04-28T18:04:57.741346Z","steps":["trace[1372774720] 'process raft request' (duration: 182.497121ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:04:57.741574Z","caller":"traceutil/trace.go:171","msg":"trace[296469484] transaction","detail":"{read_only:false; response_revision:20623; number_of_response:1; }","duration":"148.76028ms","start":"2026-04-28T18:04:57.592803Z","end":"2026-04-28T18:04:57.741564Z","steps":["trace[296469484] 'process raft request' (duration: 148.407822ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:04:57.74155Z","caller":"traceutil/trace.go:171","msg":"trace[266098711] transaction","detail":"{read_only:false; response_revision:20624; number_of_response:1; }","duration":"148.444602ms","start":"2026-04-28T18:04:57.593097Z","end":"2026-04-28T18:04:57.741542Z","steps":["trace[266098711] 'process raft request' (duration: 148.378131ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:04:57.918521Z","caller":"traceutil/trace.go:171","msg":"trace[1452109637] linearizableReadLoop","detail":"{readStateIndex:21309; appliedIndex:21308; }","duration":"156.032864ms","start":"2026-04-28T18:04:57.762444Z","end":"2026-04-28T18:04:57.918477Z","steps":["trace[1452109637] 'read index received' (duration: 155.744148ms)","trace[1452109637] 'applied index is now lower than readState.Index' (duration: 287.796µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:04:57.918565Z","caller":"traceutil/trace.go:171","msg":"trace[2001456130] transaction","detail":"{read_only:false; response_revision:20625; number_of_response:1; }","duration":"173.111775ms","start":"2026-04-28T18:04:57.745425Z","end":"2026-04-28T18:04:57.918537Z","steps":["trace[2001456130] 'process raft request' (duration: 172.823309ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:04:57.918679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.222737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:04:57.918758Z","caller":"traceutil/trace.go:171","msg":"trace[640993395] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20625; }","duration":"156.34625ms","start":"2026-04-28T18:04:57.762394Z","end":"2026-04-28T18:04:57.91874Z","steps":["trace[640993395] 'agreement among raft nodes before linearized reading' (duration: 156.219178ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:08:29.58965Z","caller":"traceutil/trace.go:171","msg":"trace[1536162316] transaction","detail":"{read_only:false; response_revision:22984; number_of_response:1; }","duration":"106.159879ms","start":"2026-04-28T18:08:29.483455Z","end":"2026-04-28T18:08:29.589615Z","steps":["trace[1536162316] 'process raft request' (duration: 105.824942ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:09:17.660209Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20418} {"level":"info","ts":"2026-04-28T18:09:17.776008Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20418,"took":"111.748821ms","hash":1236818249,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":42020864,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-04-28T18:09:17.776109Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1236818249,"revision":20418,"compact-revision":17933} {"level":"info","ts":"2026-04-28T18:11:50.551801Z","caller":"traceutil/trace.go:171","msg":"trace[1704158615] transaction","detail":"{read_only:false; response_revision:25081; number_of_response:1; }","duration":"131.832738ms","start":"2026-04-28T18:11:50.419933Z","end":"2026-04-28T18:11:50.551766Z","steps":["trace[1704158615] 'process raft request' (duration: 131.635004ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:50.824718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.324109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-28T18:11:50.824783Z","caller":"traceutil/trace.go:171","msg":"trace[1702064306] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25081; }","duration":"202.453722ms","start":"2026-04-28T18:11:50.622316Z","end":"2026-04-28T18:11:50.82477Z","steps":["trace[1702064306] 'range keys from in-memory index tree' (duration: 202.163285ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:50.824809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.222792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:11:50.824883Z","caller":"traceutil/trace.go:171","msg":"trace[1693289270] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25081; }","duration":"233.353415ms","start":"2026-04-28T18:11:50.591512Z","end":"2026-04-28T18:11:50.824865Z","steps":["trace[1693289270] 'count revisions from in-memory index tree' (duration: 233.13423ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:50.824891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.851721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-28T18:11:50.824961Z","caller":"traceutil/trace.go:171","msg":"trace[926778415] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25081; }","duration":"153.972264ms","start":"2026-04-28T18:11:50.670975Z","end":"2026-04-28T18:11:50.824948Z","steps":["trace[926778415] 'range keys from in-memory index tree' (duration: 153.697368ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:50.998121Z","caller":"traceutil/trace.go:171","msg":"trace[1241126988] transaction","detail":"{read_only:false; response_revision:25082; number_of_response:1; }","duration":"170.12849ms","start":"2026-04-28T18:11:50.827964Z","end":"2026-04-28T18:11:50.998092Z","steps":["trace[1241126988] 'process raft request' (duration: 169.895815ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:51.177968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.294767ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:11:51.178097Z","caller":"traceutil/trace.go:171","msg":"trace[429710904] transaction","detail":"{read_only:false; response_revision:25083; number_of_response:1; }","duration":"349.64079ms","start":"2026-04-28T18:11:50.828443Z","end":"2026-04-28T18:11:51.178083Z","steps":["trace[429710904] 'process raft request' (duration: 215.166508ms)","trace[429710904] 'compare' (duration: 134.206635ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:51.178141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:50.828427Z","time spent":"349.693421ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:11:51.178405Z","caller":"traceutil/trace.go:171","msg":"trace[680929877] transaction","detail":"{read_only:false; response_revision:25084; number_of_response:1; }","duration":"349.363885ms","start":"2026-04-28T18:11:50.829033Z","end":"2026-04-28T18:11:51.178396Z","steps":["trace[680929877] 'process raft request' (duration: 349.024018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:51.178453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:50.829018Z","time spent":"349.408355ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:11:51.178453Z","caller":"traceutil/trace.go:171","msg":"trace[110354564] linearizableReadLoop","detail":"{readStateIndex:25890; appliedIndex:25888; }","duration":"286.310043ms","start":"2026-04-28T18:11:50.892111Z","end":"2026-04-28T18:11:51.178421Z","steps":["trace[110354564] 'read index received' (duration: 105.966296ms)","trace[110354564] 'applied index is now lower than readState.Index' (duration: 180.342837ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:51.178622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.511337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.125\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-04-28T18:11:51.178663Z","caller":"traceutil/trace.go:171","msg":"trace[1854341530] range","detail":"{range_begin:/registry/masterleases/199.19.213.125; range_end:; response_count:1; response_revision:25085; }","duration":"286.583839ms","start":"2026-04-28T18:11:50.892068Z","end":"2026-04-28T18:11:51.178652Z","steps":["trace[1854341530] 'agreement among raft nodes before linearized reading' (duration: 286.453506ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:51.178736Z","caller":"traceutil/trace.go:171","msg":"trace[763949270] transaction","detail":"{read_only:false; response_revision:25085; number_of_response:1; }","duration":"159.752661ms","start":"2026-04-28T18:11:51.01892Z","end":"2026-04-28T18:11:51.178673Z","steps":["trace[763949270] 'process raft request' (duration: 159.418475ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:55.778061Z","caller":"traceutil/trace.go:171","msg":"trace[1268417731] transaction","detail":"{read_only:false; response_revision:25125; number_of_response:1; }","duration":"121.724555ms","start":"2026-04-28T18:11:55.656315Z","end":"2026-04-28T18:11:55.77804Z","steps":["trace[1268417731] 'process raft request' (duration: 121.257225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:56.026861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.977272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:11:56.027007Z","caller":"traceutil/trace.go:171","msg":"trace[1516056896] transaction","detail":"{read_only:false; response_revision:25126; number_of_response:1; }","duration":"245.05635ms","start":"2026-04-28T18:11:55.781921Z","end":"2026-04-28T18:11:56.026977Z","steps":["trace[1516056896] 'process raft request' (duration: 110.764272ms)","trace[1516056896] 'compare' (duration: 133.757038ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:56.2933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.058558ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-28T18:11:56.293425Z","caller":"traceutil/trace.go:171","msg":"trace[1995188523] linearizableReadLoop","detail":"{readStateIndex:25934; appliedIndex:25933; }","duration":"186.717884ms","start":"2026-04-28T18:11:56.106671Z","end":"2026-04-28T18:11:56.293389Z","steps":["trace[1995188523] 'read index received' (duration: 14.508532ms)","trace[1995188523] 'applied index is now lower than readState.Index' (duration: 172.208022ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:56.293947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.250846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-04-28T18:11:56.294123Z","caller":"traceutil/trace.go:171","msg":"trace[180815304] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25126; }","duration":"187.446169ms","start":"2026-04-28T18:11:56.106651Z","end":"2026-04-28T18:11:56.294097Z","steps":["trace[180815304] 'agreement among raft nodes before linearized reading' (duration: 187.046942ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:56.560255Z","caller":"traceutil/trace.go:171","msg":"trace[1698345911] transaction","detail":"{read_only:false; response_revision:25127; number_of_response:1; }","duration":"261.232127ms","start":"2026-04-28T18:11:56.298997Z","end":"2026-04-28T18:11:56.560229Z","steps":["trace[1698345911] 'process raft request' (duration: 261.066674ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:56.759714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.206547ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:11:56.760008Z","caller":"traceutil/trace.go:171","msg":"trace[795733536] transaction","detail":"{read_only:false; response_revision:25128; number_of_response:1; }","duration":"460.480565ms","start":"2026-04-28T18:11:56.299496Z","end":"2026-04-28T18:11:56.759977Z","steps":["trace[795733536] 'process raft request' (duration: 320.88087ms)","trace[795733536] 'compare' (duration: 139.110205ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:56.760063Z","caller":"traceutil/trace.go:171","msg":"trace[1462601014] transaction","detail":"{read_only:false; response_revision:25129; number_of_response:1; }","duration":"188.378458ms","start":"2026-04-28T18:11:56.571668Z","end":"2026-04-28T18:11:56.760046Z","steps":["trace[1462601014] 'process raft request' (duration: 188.143393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:56.760163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:56.29947Z","time spent":"460.613317ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:11:57.206409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.963218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:36 size:299321"} {"level":"info","ts":"2026-04-28T18:11:57.206487Z","caller":"traceutil/trace.go:171","msg":"trace[774515117] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:36; response_revision:25130; }","duration":"117.09142ms","start":"2026-04-28T18:11:57.089378Z","end":"2026-04-28T18:11:57.20647Z","steps":["trace[774515117] 'range keys from in-memory index tree' (duration: 116.274464ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:57.494795Z","caller":"traceutil/trace.go:171","msg":"trace[1200919590] transaction","detail":"{read_only:false; response_revision:25132; number_of_response:1; }","duration":"300.03916ms","start":"2026-04-28T18:11:57.194718Z","end":"2026-04-28T18:11:57.494757Z","steps":["trace[1200919590] 'process raft request' (duration: 299.724864ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:57.494846Z","caller":"traceutil/trace.go:171","msg":"trace[1166921450] linearizableReadLoop","detail":"{readStateIndex:25940; appliedIndex:25939; }","duration":"292.16921ms","start":"2026-04-28T18:11:57.20265Z","end":"2026-04-28T18:11:57.494819Z","steps":["trace[1166921450] 'read index received' (duration: 61.842607ms)","trace[1166921450] 'applied index is now lower than readState.Index' (duration: 230.325263ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:57.494999Z","caller":"traceutil/trace.go:171","msg":"trace[719313885] transaction","detail":"{read_only:false; response_revision:25135; number_of_response:1; }","duration":"231.234441ms","start":"2026-04-28T18:11:57.263738Z","end":"2026-04-28T18:11:57.494972Z","steps":["trace[719313885] 'process raft request' (duration: 231.033267ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:57.495152Z","caller":"traceutil/trace.go:171","msg":"trace[484985416] transaction","detail":"{read_only:false; response_revision:25133; number_of_response:1; }","duration":"238.329876ms","start":"2026-04-28T18:11:57.256816Z","end":"2026-04-28T18:11:57.495146Z","steps":["trace[484985416] 'process raft request' (duration: 237.840065ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:57.495248Z","caller":"traceutil/trace.go:171","msg":"trace[2108680328] transaction","detail":"{read_only:false; response_revision:25134; number_of_response:1; }","duration":"231.693742ms","start":"2026-04-28T18:11:57.263548Z","end":"2026-04-28T18:11:57.495242Z","steps":["trace[2108680328] 'process raft request' (duration: 231.17295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:57.495372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.691121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-04-28T18:11:57.495335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.655881ms","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-04-28T18:11:57.495522Z","caller":"traceutil/trace.go:171","msg":"trace[1725678595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25135; }","duration":"292.899376ms","start":"2026-04-28T18:11:57.2026Z","end":"2026-04-28T18:11:57.4955Z","steps":["trace[1725678595] 'agreement among raft nodes before linearized reading' (duration: 292.367264ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:57.495577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:57.194688Z","time spent":"300.183772ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:11:57.495442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.052503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"info","ts":"2026-04-28T18:11:57.495846Z","caller":"traceutil/trace.go:171","msg":"trace[94237637] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25135; }","duration":"136.499812ms","start":"2026-04-28T18:11:57.359334Z","end":"2026-04-28T18:11:57.495834Z","steps":["trace[94237637] 'agreement among raft nodes before linearized reading' (duration: 135.88126ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:57.49545Z","caller":"traceutil/trace.go:171","msg":"trace[170853289] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25135; }","duration":"292.818154ms","start":"2026-04-28T18:11:57.202616Z","end":"2026-04-28T18:11:57.495434Z","steps":["trace[170853289] 'agreement among raft nodes before linearized reading' (duration: 292.520068ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:57.647258Z","caller":"traceutil/trace.go:171","msg":"trace[1531857279] transaction","detail":"{read_only:false; response_revision:25136; number_of_response:1; }","duration":"146.411971ms","start":"2026-04-28T18:11:57.500761Z","end":"2026-04-28T18:11:57.647173Z","steps":["trace[1531857279] 'process raft request' (duration: 132.806447ms)","trace[1531857279] 'compare' (duration: 13.289398ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:57.945101Z","caller":"traceutil/trace.go:171","msg":"trace[1860517380] transaction","detail":"{read_only:false; response_revision:25138; number_of_response:1; }","duration":"443.342579ms","start":"2026-04-28T18:11:57.501736Z","end":"2026-04-28T18:11:57.945079Z","steps":["trace[1860517380] 'process raft request' (duration: 443.237557ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:57.945238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:57.501729Z","time spent":"443.440871ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:11:57.945316Z","caller":"traceutil/trace.go:171","msg":"trace[1726922660] transaction","detail":"{read_only:false; response_revision:25137; number_of_response:1; }","duration":"443.974931ms","start":"2026-04-28T18:11:57.501311Z","end":"2026-04-28T18:11:57.945286Z","steps":["trace[1726922660] 'process raft request' (duration: 410.19681ms)","trace[1726922660] 'compare' (duration: 33.321402ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:57.9455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:57.501303Z","time spent":"444.100303ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:11:57.945327Z","caller":"traceutil/trace.go:171","msg":"trace[1948296201] linearizableReadLoop","detail":"{readStateIndex:25946; appliedIndex:25943; }","duration":"441.921721ms","start":"2026-04-28T18:11:57.503371Z","end":"2026-04-28T18:11:57.945293Z","steps":["trace[1948296201] 'read index received' (duration: 130.141195ms)","trace[1948296201] 'applied index is now lower than readState.Index' (duration: 311.778906ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:57.945747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.404028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:11:57.945806Z","caller":"traceutil/trace.go:171","msg":"trace[1736036022] transaction","detail":"{read_only:false; response_revision:25139; number_of_response:1; }","duration":"393.642846ms","start":"2026-04-28T18:11:57.55215Z","end":"2026-04-28T18:11:57.945793Z","steps":["trace[1736036022] 'process raft request' (duration: 392.894831ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:57.945849Z","caller":"traceutil/trace.go:171","msg":"trace[302949224] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25139; }","duration":"184.52867ms","start":"2026-04-28T18:11:57.761302Z","end":"2026-04-28T18:11:57.94583Z","steps":["trace[302949224] 'agreement among raft nodes before linearized reading' (duration: 184.395287ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:57.945854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.634489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"warn","ts":"2026-04-28T18:11:57.945888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:57.552114Z","time spent":"393.723558ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:11:57.945905Z","caller":"traceutil/trace.go:171","msg":"trace[1063796501] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25139; }","duration":"163.68628ms","start":"2026-04-28T18:11:57.782207Z","end":"2026-04-28T18:11:57.945893Z","steps":["trace[1063796501] 'agreement among raft nodes before linearized reading' (duration: 163.524337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:57.946324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"442.177966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"} {"level":"info","ts":"2026-04-28T18:11:57.946398Z","caller":"traceutil/trace.go:171","msg":"trace[321536188] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25139; }","duration":"443.022343ms","start":"2026-04-28T18:11:57.503353Z","end":"2026-04-28T18:11:57.946375Z","steps":["trace[321536188] 'agreement among raft nodes before linearized reading' (duration: 442.040513ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:57.946474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:57.503345Z","time spent":"443.094375ms","remote":"127.0.0.1:52790","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":"warn","ts":"2026-04-28T18:11:58.29042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.028018ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:11:58.290531Z","caller":"traceutil/trace.go:171","msg":"trace[1724486818] linearizableReadLoop","detail":"{readStateIndex:25949; appliedIndex:25948; }","duration":"248.063181ms","start":"2026-04-28T18:11:58.042451Z","end":"2026-04-28T18:11:58.290514Z","steps":["trace[1724486818] 'read index received' (duration: 133.796788ms)","trace[1724486818] 'applied index is now lower than readState.Index' (duration: 114.265053ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:58.290631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.174623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:11:58.290633Z","caller":"traceutil/trace.go:171","msg":"trace[1930521276] transaction","detail":"{read_only:false; response_revision:25141; number_of_response:1; }","duration":"256.143514ms","start":"2026-04-28T18:11:58.034459Z","end":"2026-04-28T18:11:58.290603Z","steps":["trace[1930521276] 'process raft request' (duration: 141.84389ms)","trace[1930521276] 'compare' (duration: 113.861825ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:58.290667Z","caller":"traceutil/trace.go:171","msg":"trace[1412849183] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:25141; }","duration":"248.230774ms","start":"2026-04-28T18:11:58.042426Z","end":"2026-04-28T18:11:58.290656Z","steps":["trace[1412849183] 'agreement among raft nodes before linearized reading' (duration: 248.138492ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:58.516058Z","caller":"traceutil/trace.go:171","msg":"trace[644844934] linearizableReadLoop","detail":"{readStateIndex:25950; appliedIndex:25949; }","duration":"125.659663ms","start":"2026-04-28T18:11:58.39037Z","end":"2026-04-28T18:11:58.51603Z","steps":["trace[644844934] 'read index received' (duration: 122.238245ms)","trace[644844934] 'applied index is now lower than readState.Index' (duration: 3.420298ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:58.516096Z","caller":"traceutil/trace.go:171","msg":"trace[913510707] transaction","detail":"{read_only:false; response_revision:25142; number_of_response:1; }","duration":"127.246095ms","start":"2026-04-28T18:11:58.388819Z","end":"2026-04-28T18:11:58.516065Z","steps":["trace[913510707] 'process raft request' (duration: 123.807966ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:58.516305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.924718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-12f14219-4290-430f-a1ac-877e5be2f263\" ","response":"range_response_count:1 size:1316"} {"level":"info","ts":"2026-04-28T18:11:58.516348Z","caller":"traceutil/trace.go:171","msg":"trace[120664853] range","detail":"{range_begin:/registry/persistentvolumes/pvc-12f14219-4290-430f-a1ac-877e5be2f263; range_end:; response_count:1; response_revision:25142; }","duration":"126.016141ms","start":"2026-04-28T18:11:58.39032Z","end":"2026-04-28T18:11:58.516336Z","steps":["trace[120664853] 'agreement among raft nodes before linearized reading' (duration: 125.806986ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:58.760136Z","caller":"traceutil/trace.go:171","msg":"trace[770141079] transaction","detail":"{read_only:false; response_revision:25143; number_of_response:1; }","duration":"192.846299ms","start":"2026-04-28T18:11:58.567268Z","end":"2026-04-28T18:11:58.760114Z","steps":["trace[770141079] 'process raft request' (duration: 192.370749ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:59.066811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.185349ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:11:59.066956Z","caller":"traceutil/trace.go:171","msg":"trace[512185046] linearizableReadLoop","detail":"{readStateIndex:25953; appliedIndex:25952; }","duration":"162.031087ms","start":"2026-04-28T18:11:58.904904Z","end":"2026-04-28T18:11:59.066935Z","steps":["trace[512185046] 'read index received' (duration: 11.603674ms)","trace[512185046] 'applied index is now lower than readState.Index' (duration: 150.425413ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:59.067071Z","caller":"traceutil/trace.go:171","msg":"trace[2054518983] transaction","detail":"{read_only:false; response_revision:25145; number_of_response:1; }","duration":"300.263995ms","start":"2026-04-28T18:11:58.76679Z","end":"2026-04-28T18:11:59.067054Z","steps":["trace[2054518983] 'process raft request' (duration: 149.73485ms)","trace[2054518983] 'compare' (duration: 149.939132ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:11:59.067196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:58.766775Z","time spent":"300.346736ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:11:59.067422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.305073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-28T18:11:59.067474Z","caller":"traceutil/trace.go:171","msg":"trace[1253300647] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:25145; }","duration":"162.610569ms","start":"2026-04-28T18:11:58.904852Z","end":"2026-04-28T18:11:59.067463Z","steps":["trace[1253300647] 'agreement among raft nodes before linearized reading' (duration: 162.266582ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:59.866192Z","caller":"traceutil/trace.go:171","msg":"trace[742785788] transaction","detail":"{read_only:false; response_revision:25148; number_of_response:1; }","duration":"364.200123ms","start":"2026-04-28T18:11:59.501958Z","end":"2026-04-28T18:11:59.866159Z","steps":["trace[742785788] 'process raft request' (duration: 346.592609ms)","trace[742785788] 'compare' (duration: 17.132805ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:59.866202Z","caller":"traceutil/trace.go:171","msg":"trace[1615376991] linearizableReadLoop","detail":"{readStateIndex:25958; appliedIndex:25955; }","duration":"237.915967ms","start":"2026-04-28T18:11:59.628262Z","end":"2026-04-28T18:11:59.866178Z","steps":["trace[1615376991] 'read index received' (duration: 220.508296ms)","trace[1615376991] 'applied index is now lower than readState.Index' (duration: 17.406451ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:11:59.866249Z","caller":"traceutil/trace.go:171","msg":"trace[2092896428] transaction","detail":"{read_only:false; response_revision:25149; number_of_response:1; }","duration":"363.643612ms","start":"2026-04-28T18:11:59.502574Z","end":"2026-04-28T18:11:59.866218Z","steps":["trace[2092896428] 'process raft request' (duration: 363.460679ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:11:59.866267Z","caller":"traceutil/trace.go:171","msg":"trace[505462054] transaction","detail":"{read_only:false; response_revision:25150; number_of_response:1; }","duration":"362.711614ms","start":"2026-04-28T18:11:59.503531Z","end":"2026-04-28T18:11:59.866243Z","steps":["trace[505462054] 'process raft request' (duration: 362.599492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:59.866424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:59.502556Z","time spent":"363.798755ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:11:59.866449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:59.50352Z","time spent":"362.849796ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:11:59.866469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.189172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-04-28T18:11:59.866507Z","caller":"traceutil/trace.go:171","msg":"trace[287901703] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25150; }","duration":"238.281974ms","start":"2026-04-28T18:11:59.628214Z","end":"2026-04-28T18:11:59.866496Z","steps":["trace[287901703] 'agreement among raft nodes before linearized reading' (duration: 238.125501ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:59.866424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:11:59.501915Z","time spent":"364.359476ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:11:59.866847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.321922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-28T18:11:59.866879Z","caller":"traceutil/trace.go:171","msg":"trace[1433788589] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25150; }","duration":"215.395042ms","start":"2026-04-28T18:11:59.651477Z","end":"2026-04-28T18:11:59.866872Z","steps":["trace[1433788589] 'agreement among raft nodes before linearized reading' (duration: 215.310761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:11:59.866949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.007277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:11:59.86702Z","caller":"traceutil/trace.go:171","msg":"trace[1849681853] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25150; }","duration":"103.118199ms","start":"2026-04-28T18:11:59.763884Z","end":"2026-04-28T18:11:59.867002Z","steps":["trace[1849681853] 'agreement among raft nodes before linearized reading' (duration: 103.007807ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:00.069599Z","caller":"traceutil/trace.go:171","msg":"trace[229835869] linearizableReadLoop","detail":"{readStateIndex:25959; appliedIndex:25958; }","duration":"196.36188ms","start":"2026-04-28T18:11:59.873212Z","end":"2026-04-28T18:12:00.069574Z","steps":["trace[229835869] 'read index received' (duration: 130.102354ms)","trace[229835869] 'applied index is now lower than readState.Index' (duration: 66.258426ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:00.069854Z","caller":"traceutil/trace.go:171","msg":"trace[613516308] transaction","detail":"{read_only:false; response_revision:25151; number_of_response:1; }","duration":"197.049194ms","start":"2026-04-28T18:11:59.872769Z","end":"2026-04-28T18:12:00.069818Z","steps":["trace[613516308] 'process raft request' (duration: 130.504442ms)","trace[613516308] 'compare' (duration: 66.199544ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:00.0699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.646145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18256"} {"level":"warn","ts":"2026-04-28T18:12:00.069945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.837477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"info","ts":"2026-04-28T18:12:00.069988Z","caller":"traceutil/trace.go:171","msg":"trace[1885360385] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25151; }","duration":"118.919298ms","start":"2026-04-28T18:11:59.951054Z","end":"2026-04-28T18:12:00.069974Z","steps":["trace[1885360385] 'agreement among raft nodes before linearized reading' (duration: 118.770115ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:00.069995Z","caller":"traceutil/trace.go:171","msg":"trace[387531536] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25151; }","duration":"196.794419ms","start":"2026-04-28T18:11:59.873176Z","end":"2026-04-28T18:12:00.06997Z","steps":["trace[387531536] 'agreement among raft nodes before linearized reading' (duration: 196.545284ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:00.070174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.234761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:12:00.070221Z","caller":"traceutil/trace.go:171","msg":"trace[1739462334] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:25151; }","duration":"102.285802ms","start":"2026-04-28T18:11:59.967923Z","end":"2026-04-28T18:12:00.070209Z","steps":["trace[1739462334] 'agreement among raft nodes before linearized reading' (duration: 102.206701ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:00.070233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.099551ms","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-04-28T18:12:00.07027Z","caller":"traceutil/trace.go:171","msg":"trace[260041488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25151; }","duration":"118.146931ms","start":"2026-04-28T18:11:59.952114Z","end":"2026-04-28T18:12:00.070261Z","steps":["trace[260041488] 'agreement among raft nodes before linearized reading' (duration: 118.048299ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:00.206079Z","caller":"traceutil/trace.go:171","msg":"trace[915542140] transaction","detail":"{read_only:false; response_revision:25152; number_of_response:1; }","duration":"132.290887ms","start":"2026-04-28T18:12:00.073756Z","end":"2026-04-28T18:12:00.206047Z","steps":["trace[915542140] 'process raft request' (duration: 119.743934ms)","trace[915542140] 'compare' (duration: 12.42743ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:00.545136Z","caller":"traceutil/trace.go:171","msg":"trace[317459964] transaction","detail":"{read_only:false; response_revision:25153; number_of_response:1; }","duration":"470.742711ms","start":"2026-04-28T18:12:00.074361Z","end":"2026-04-28T18:12:00.545103Z","steps":["trace[317459964] 'process raft request' (duration: 457.7736ms)","trace[317459964] 'compare' (duration: 12.102864ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:00.545271Z","caller":"traceutil/trace.go:171","msg":"trace[1925693165] linearizableReadLoop","detail":"{readStateIndex:25962; appliedIndex:25959; }","duration":"416.396525ms","start":"2026-04-28T18:12:00.128849Z","end":"2026-04-28T18:12:00.545245Z","steps":["trace[1925693165] 'read index received' (duration: 64.662374ms)","trace[1925693165] 'applied index is now lower than readState.Index' (duration: 351.733151ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:00.545318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:00.07434Z","time spent":"470.887753ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:00.54541Z","caller":"traceutil/trace.go:171","msg":"trace[1265279641] transaction","detail":"{read_only:false; response_revision:25154; number_of_response:1; }","duration":"470.471516ms","start":"2026-04-28T18:12:00.074927Z","end":"2026-04-28T18:12:00.545399Z","steps":["trace[1265279641] 'process raft request' (duration: 470.066828ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:00.545524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:00.074918Z","time spent":"470.524927ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:00.54553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.139279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-28T18:12:00.545538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.66858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:12:00.545616Z","caller":"traceutil/trace.go:171","msg":"trace[55655055] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/endpoints/; range_end:/registry/openstack.k-orc.cloud/endpoints0; response_count:0; response_revision:25154; }","duration":"410.242821ms","start":"2026-04-28T18:12:00.135355Z","end":"2026-04-28T18:12:00.545598Z","steps":["trace[55655055] 'agreement among raft nodes before linearized reading' (duration: 410.091618ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:00.545651Z","caller":"traceutil/trace.go:171","msg":"trace[968591075] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25154; }","duration":"416.823673ms","start":"2026-04-28T18:12:00.128808Z","end":"2026-04-28T18:12:00.545631Z","steps":["trace[968591075] 'agreement among raft nodes before linearized reading' (duration: 416.63746ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:00.545705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:00.128787Z","time spent":"416.908435ms","remote":"127.0.0.1:53064","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-28T18:12:00.545661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:00.135319Z","time spent":"410.330993ms","remote":"127.0.0.1:58974","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/endpoints/\" range_end:\"/registry/openstack.k-orc.cloud/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-04-28T18:12:00.545786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.745461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-28T18:12:00.545797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.5341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-04-28T18:12:00.545837Z","caller":"traceutil/trace.go:171","msg":"trace[124811081] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25154; }","duration":"406.820133ms","start":"2026-04-28T18:12:00.139002Z","end":"2026-04-28T18:12:00.545822Z","steps":["trace[124811081] 'agreement among raft nodes before linearized reading' (duration: 406.73756ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:00.545846Z","caller":"traceutil/trace.go:171","msg":"trace[1369366622] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25154; }","duration":"251.616153ms","start":"2026-04-28T18:12:00.294219Z","end":"2026-04-28T18:12:00.545836Z","steps":["trace[1369366622] 'agreement among raft nodes before linearized reading' (duration: 251.464479ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:00.545877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:00.138958Z","time spent":"406.910205ms","remote":"127.0.0.1:58814","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true "} {"level":"warn","ts":"2026-04-28T18:12:00.545954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.004189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:12:00.546082Z","caller":"traceutil/trace.go:171","msg":"trace[636243568] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/domains/; range_end:/registry/openstack.k-orc.cloud/domains0; response_count:0; response_revision:25154; }","duration":"300.186033ms","start":"2026-04-28T18:12:00.245875Z","end":"2026-04-28T18:12:00.546061Z","steps":["trace[636243568] 'agreement among raft nodes before linearized reading' (duration: 299.876806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:00.546146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:00.245854Z","time spent":"300.279455ms","remote":"127.0.0.1:58998","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/domains/\" range_end:\"/registry/openstack.k-orc.cloud/domains0\" count_only:true "} {"level":"warn","ts":"2026-04-28T18:12:00.815362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.293763ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:00.815583Z","caller":"traceutil/trace.go:171","msg":"trace[450602481] linearizableReadLoop","detail":"{readStateIndex:25963; appliedIndex:25962; }","duration":"261.320679ms","start":"2026-04-28T18:12:00.554249Z","end":"2026-04-28T18:12:00.81557Z","steps":["trace[450602481] 'read index received' (duration: 96.72418ms)","trace[450602481] 'applied index is now lower than readState.Index' (duration: 164.595849ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:00.815574Z","caller":"traceutil/trace.go:171","msg":"trace[1069649113] transaction","detail":"{read_only:false; response_revision:25155; number_of_response:1; }","duration":"263.913521ms","start":"2026-04-28T18:12:00.551616Z","end":"2026-04-28T18:12:00.815529Z","steps":["trace[1069649113] 'process raft request' (duration: 99.386733ms)","trace[1069649113] 'compare' (duration: 164.188901ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:00.815867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.599824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-04-28T18:12:00.816488Z","caller":"traceutil/trace.go:171","msg":"trace[978532780] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25156; }","duration":"261.726378ms","start":"2026-04-28T18:12:00.554204Z","end":"2026-04-28T18:12:00.815931Z","steps":["trace[978532780] 'agreement among raft nodes before linearized reading' (duration: 261.408832ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:10.054206Z","caller":"traceutil/trace.go:171","msg":"trace[325635102] transaction","detail":"{read_only:false; response_revision:25284; number_of_response:1; }","duration":"155.327292ms","start":"2026-04-28T18:12:09.898854Z","end":"2026-04-28T18:12:10.054181Z","steps":["trace[325635102] 'process raft request' (duration: 145.965123ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:10.054424Z","caller":"traceutil/trace.go:171","msg":"trace[1989793694] transaction","detail":"{read_only:false; response_revision:25285; number_of_response:1; }","duration":"154.643688ms","start":"2026-04-28T18:12:09.899768Z","end":"2026-04-28T18:12:10.054412Z","steps":["trace[1989793694] 'process raft request' (duration: 154.375672ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:10.054409Z","caller":"traceutil/trace.go:171","msg":"trace[1227302743] linearizableReadLoop","detail":"{readStateIndex:26095; appliedIndex:26093; }","duration":"125.132293ms","start":"2026-04-28T18:12:09.92924Z","end":"2026-04-28T18:12:10.054372Z","steps":["trace[1227302743] 'read index received' (duration: 115.558939ms)","trace[1227302743] 'applied index is now lower than readState.Index' (duration: 9.570074ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:10.054784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.522971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a66739b5-5a50-4a7a-8ecd-e4264a080815\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-04-28T18:12:10.054845Z","caller":"traceutil/trace.go:171","msg":"trace[567116586] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a66739b5-5a50-4a7a-8ecd-e4264a080815; range_end:; response_count:1; response_revision:25285; }","duration":"125.641513ms","start":"2026-04-28T18:12:09.929188Z","end":"2026-04-28T18:12:10.054829Z","steps":["trace[567116586] 'agreement among raft nodes before linearized reading' (duration: 125.306606ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:10.340055Z","caller":"traceutil/trace.go:171","msg":"trace[1951104234] transaction","detail":"{read_only:false; response_revision:25286; number_of_response:1; }","duration":"225.13994ms","start":"2026-04-28T18:12:10.114873Z","end":"2026-04-28T18:12:10.340012Z","steps":["trace[1951104234] 'process raft request' (duration: 190.737566ms)","trace[1951104234] 'compare' (duration: 33.685329ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:10.59006Z","caller":"traceutil/trace.go:171","msg":"trace[207675967] transaction","detail":"{read_only:false; response_revision:25288; number_of_response:1; }","duration":"208.278179ms","start":"2026-04-28T18:12:10.38173Z","end":"2026-04-28T18:12:10.590008Z","steps":["trace[207675967] 'process raft request' (duration: 116.876746ms)","trace[207675967] 'compare' (duration: 91.153458ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:11.008329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.282499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:11.008651Z","caller":"traceutil/trace.go:171","msg":"trace[1749827080] transaction","detail":"{read_only:false; response_revision:25290; number_of_response:1; }","duration":"408.445154ms","start":"2026-04-28T18:12:10.600186Z","end":"2026-04-28T18:12:11.008631Z","steps":["trace[1749827080] 'process raft request' (duration: 408.353192ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:11.008686Z","caller":"traceutil/trace.go:171","msg":"trace[1331784777] transaction","detail":"{read_only:false; response_revision:25289; number_of_response:1; }","duration":"410.881804ms","start":"2026-04-28T18:12:10.597767Z","end":"2026-04-28T18:12:11.008649Z","steps":["trace[1331784777] 'process raft request' (duration: 136.691616ms)","trace[1331784777] 'compare' (duration: 272.892532ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:11.008733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:10.600152Z","time spent":"408.539416ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:11.008798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:10.597742Z","time spent":"411.006776ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:11.019225Z","caller":"traceutil/trace.go:171","msg":"trace[1246035166] linearizableReadLoop","detail":"{readStateIndex:26101; appliedIndex:26100; }","duration":"142.681756ms","start":"2026-04-28T18:12:10.876523Z","end":"2026-04-28T18:12:11.019205Z","steps":["trace[1246035166] 'read index received' (duration: 142.567344ms)","trace[1246035166] 'applied index is now lower than readState.Index' (duration: 113.622µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:11.019358Z","caller":"traceutil/trace.go:171","msg":"trace[1309208478] transaction","detail":"{read_only:false; response_revision:25291; number_of_response:1; }","duration":"165.848794ms","start":"2026-04-28T18:12:10.853491Z","end":"2026-04-28T18:12:11.01934Z","steps":["trace[1309208478] 'process raft request' (duration: 165.614519ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.019627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.990549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.125\" ","response":"range_response_count:1 size:140"} {"level":"warn","ts":"2026-04-28T18:12:11.019632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.783874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3237"} {"level":"info","ts":"2026-04-28T18:12:11.01967Z","caller":"traceutil/trace.go:171","msg":"trace[2109615205] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25291; }","duration":"119.845415ms","start":"2026-04-28T18:12:10.899813Z","end":"2026-04-28T18:12:11.019658Z","steps":["trace[2109615205] 'agreement among raft nodes before linearized reading' (duration: 119.688162ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:11.019668Z","caller":"traceutil/trace.go:171","msg":"trace[369346797] range","detail":"{range_begin:/registry/masterleases/199.19.213.125; range_end:; response_count:1; response_revision:25291; }","duration":"127.068991ms","start":"2026-04-28T18:12:10.892586Z","end":"2026-04-28T18:12:11.019655Z","steps":["trace[369346797] 'agreement among raft nodes before linearized reading' (duration: 126.936739ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.019664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.571175ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-28T18:12:11.019757Z","caller":"traceutil/trace.go:171","msg":"trace[95314188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25291; }","duration":"142.703607ms","start":"2026-04-28T18:12:10.877027Z","end":"2026-04-28T18:12:11.01973Z","steps":["trace[95314188] 'agreement among raft nodes before linearized reading' (duration: 142.415191ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.019765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.242698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-28T18:12:11.019808Z","caller":"traceutil/trace.go:171","msg":"trace[905251578] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25291; }","duration":"143.320199ms","start":"2026-04-28T18:12:10.876476Z","end":"2026-04-28T18:12:11.019796Z","steps":["trace[905251578] 'agreement among raft nodes before linearized reading' (duration: 143.186356ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.020058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.831754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-04-28T18:12:11.020093Z","caller":"traceutil/trace.go:171","msg":"trace[703721897] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25291; }","duration":"111.881355ms","start":"2026-04-28T18:12:10.908202Z","end":"2026-04-28T18:12:11.020083Z","steps":["trace[703721897] 'agreement among raft nodes before linearized reading' (duration: 111.263503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.396057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.312164ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-04-28T18:12:11.396309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.020598Z","time spent":"375.704815ms","remote":"127.0.0.1:52660","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-04-28T18:12:11.396412Z","caller":"traceutil/trace.go:171","msg":"trace[1446568197] linearizableReadLoop","detail":"{readStateIndex:26103; appliedIndex:26101; }","duration":"372.548692ms","start":"2026-04-28T18:12:11.023843Z","end":"2026-04-28T18:12:11.396392Z","steps":["trace[1446568197] 'read index received' (duration: 137.957351ms)","trace[1446568197] 'applied index is now lower than readState.Index' (duration: 234.590261ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:11.396684Z","caller":"traceutil/trace.go:171","msg":"trace[130189553] transaction","detail":"{read_only:false; response_revision:25292; number_of_response:1; }","duration":"372.944789ms","start":"2026-04-28T18:12:11.023726Z","end":"2026-04-28T18:12:11.396671Z","steps":["trace[130189553] 'process raft request' (duration: 372.44757ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.396795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.023697Z","time spent":"373.026102ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:11.39693Z","caller":"traceutil/trace.go:171","msg":"trace[176648471] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"276.205619ms","start":"2026-04-28T18:12:11.120695Z","end":"2026-04-28T18:12:11.396901Z","steps":["trace[176648471] 'process raft request' (duration: 275.658598ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:11.396935Z","caller":"traceutil/trace.go:171","msg":"trace[1833014235] transaction","detail":"{read_only:false; response_revision:25293; number_of_response:1; }","duration":"372.931699ms","start":"2026-04-28T18:12:11.02397Z","end":"2026-04-28T18:12:11.396901Z","steps":["trace[1833014235] 'process raft request' (duration: 372.337267ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.39706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.668668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a66739b5-5a50-4a7a-8ecd-e4264a080815\" ","response":"range_response_count:1 size:3764"} {"level":"warn","ts":"2026-04-28T18:12:11.397062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.192075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-04-28T18:12:11.397107Z","caller":"traceutil/trace.go:171","msg":"trace[348616213] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-a66739b5-5a50-4a7a-8ecd-e4264a080815; range_end:; response_count:1; response_revision:25294; }","duration":"337.738849ms","start":"2026-04-28T18:12:11.059355Z","end":"2026-04-28T18:12:11.397094Z","steps":["trace[348616213] 'agreement among raft nodes before linearized reading' (duration: 337.604076ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.397108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.023955Z","time spent":"373.064151ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:11.397146Z","caller":"traceutil/trace.go:171","msg":"trace[1147715581] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25294; }","duration":"373.304247ms","start":"2026-04-28T18:12:11.023824Z","end":"2026-04-28T18:12:11.397128Z","steps":["trace[1147715581] 'agreement among raft nodes before linearized reading' (duration: 373.051462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.397163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.059336Z","time spent":"337.819191ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3787,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-a66739b5-5a50-4a7a-8ecd-e4264a080815\" "} {"level":"warn","ts":"2026-04-28T18:12:11.397177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.677535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-28T18:12:11.397243Z","caller":"traceutil/trace.go:171","msg":"trace[1356825225] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25294; }","duration":"258.814127ms","start":"2026-04-28T18:12:11.138414Z","end":"2026-04-28T18:12:11.397228Z","steps":["trace[1356825225] 'agreement among raft nodes before linearized reading' (duration: 258.525612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.39719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.023808Z","time spent":"373.374128ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-04-28T18:12:11.397081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.95417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1155"} {"level":"info","ts":"2026-04-28T18:12:11.397415Z","caller":"traceutil/trace.go:171","msg":"trace[1817293854] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:25294; }","duration":"372.293196ms","start":"2026-04-28T18:12:11.025079Z","end":"2026-04-28T18:12:11.397373Z","steps":["trace[1817293854] 'agreement among raft nodes before linearized reading' (duration: 371.843857ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.397511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.025067Z","time spent":"372.414589ms","remote":"127.0.0.1:52724","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":1178,"request content":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" "} {"level":"warn","ts":"2026-04-28T18:12:11.787673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.871548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:11.788289Z","caller":"traceutil/trace.go:171","msg":"trace[202805310] transaction","detail":"{read_only:false; response_revision:25295; number_of_response:1; }","duration":"391.089166ms","start":"2026-04-28T18:12:11.397173Z","end":"2026-04-28T18:12:11.788262Z","steps":["trace[202805310] 'process raft request' (duration: 202.553734ms)","trace[202805310] 'compare' (duration: 187.693174ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:11.788394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.397147Z","time spent":"391.195638ms","remote":"127.0.0.1:52660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:11.789113Z","caller":"traceutil/trace.go:171","msg":"trace[1069545645] transaction","detail":"{read_only:false; response_revision:25296; number_of_response:1; }","duration":"387.616625ms","start":"2026-04-28T18:12:11.401477Z","end":"2026-04-28T18:12:11.789094Z","steps":["trace[1069545645] 'process raft request' (duration: 387.450841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.789128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.004333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18256"} {"level":"info","ts":"2026-04-28T18:12:11.789182Z","caller":"traceutil/trace.go:171","msg":"trace[100961100] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25295; }","duration":"390.082355ms","start":"2026-04-28T18:12:11.399087Z","end":"2026-04-28T18:12:11.789169Z","steps":["trace[100961100] 'agreement among raft nodes before linearized reading' (duration: 389.893271ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.78922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.39903Z","time spent":"390.183637ms","remote":"127.0.0.1:52806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18279,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-28T18:12:11.789305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.40146Z","time spent":"387.708427ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:11.79231Z","caller":"traceutil/trace.go:171","msg":"trace[1428145883] transaction","detail":"{read_only:false; response_revision:25297; number_of_response:1; }","duration":"163.256652ms","start":"2026-04-28T18:12:11.629028Z","end":"2026-04-28T18:12:11.792285Z","steps":["trace[1428145883] 'process raft request' (duration: 163.111499ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:11.791078Z","caller":"traceutil/trace.go:171","msg":"trace[682950265] linearizableReadLoop","detail":"{readStateIndex:26106; appliedIndex:26105; }","duration":"389.432572ms","start":"2026-04-28T18:12:11.399116Z","end":"2026-04-28T18:12:11.788548Z","steps":["trace[682950265] 'read index received' (duration: 197.569663ms)","trace[682950265] 'applied index is now lower than readState.Index' (duration: 191.860219ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:11.860175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.093045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" ","response":"range_response_count:1 size:1258"} {"level":"info","ts":"2026-04-28T18:12:11.860245Z","caller":"traceutil/trace.go:171","msg":"trace[2053594467] range","detail":"{range_begin:/registry/services/specs/openstack/rabbitmq-manila-nodes; range_end:; response_count:1; response_revision:25298; }","duration":"455.182907ms","start":"2026-04-28T18:12:11.405048Z","end":"2026-04-28T18:12:11.860231Z","steps":["trace[2053594467] 'agreement among raft nodes before linearized reading' (duration: 455.034964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:11.860274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.40504Z","time spent":"455.227428ms","remote":"127.0.0.1:52822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":1281,"request content":"key:\"/registry/services/specs/openstack/rabbitmq-manila-nodes\" "} {"level":"warn","ts":"2026-04-28T18:12:12.149234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.120055ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:12.149739Z","caller":"traceutil/trace.go:171","msg":"trace[1443701426] transaction","detail":"{read_only:false; response_revision:25299; number_of_response:1; }","duration":"273.749669ms","start":"2026-04-28T18:12:11.875939Z","end":"2026-04-28T18:12:12.149689Z","steps":["trace[1443701426] 'process raft request' (duration: 133.075283ms)","trace[1443701426] 'compare' (duration: 140.010652ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:12.149815Z","caller":"traceutil/trace.go:171","msg":"trace[1330397251] linearizableReadLoop","detail":"{readStateIndex:26110; appliedIndex:26109; }","duration":"272.363851ms","start":"2026-04-28T18:12:11.87741Z","end":"2026-04-28T18:12:12.149774Z","steps":["trace[1330397251] 'read index received' (duration: 131.662104ms)","trace[1330397251] 'applied index is now lower than readState.Index' (duration: 140.697597ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:12.149937Z","caller":"traceutil/trace.go:171","msg":"trace[67691492] transaction","detail":"{read_only:false; response_revision:25300; number_of_response:1; }","duration":"215.977315ms","start":"2026-04-28T18:12:11.933832Z","end":"2026-04-28T18:12:12.149809Z","steps":["trace[67691492] 'process raft request' (duration: 215.499985ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.150098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.667137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-04-28T18:12:12.150142Z","caller":"traceutil/trace.go:171","msg":"trace[1721000336] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25300; }","duration":"272.753889ms","start":"2026-04-28T18:12:11.877378Z","end":"2026-04-28T18:12:12.150132Z","steps":["trace[1721000336] 'agreement among raft nodes before linearized reading' (duration: 272.538455ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:12.217374Z","caller":"traceutil/trace.go:171","msg":"trace[849453693] transaction","detail":"{read_only:false; response_revision:25301; number_of_response:1; }","duration":"157.436544ms","start":"2026-04-28T18:12:12.05991Z","end":"2026-04-28T18:12:12.217347Z","steps":["trace[849453693] 'process raft request' (duration: 157.297211ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.226083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.584438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9600"} {"level":"info","ts":"2026-04-28T18:12:12.226131Z","caller":"traceutil/trace.go:171","msg":"trace[712875744] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25302; }","duration":"347.65604ms","start":"2026-04-28T18:12:11.878464Z","end":"2026-04-28T18:12:12.22612Z","steps":["trace[712875744] 'agreement among raft nodes before linearized reading' (duration: 347.502597ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.226158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:11.878456Z","time spent":"347.69665ms","remote":"127.0.0.1:53076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":9623,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" "} {"level":"info","ts":"2026-04-28T18:12:12.226249Z","caller":"traceutil/trace.go:171","msg":"trace[2072705054] transaction","detail":"{read_only:false; response_revision:25302; number_of_response:1; }","duration":"166.239141ms","start":"2026-04-28T18:12:12.059998Z","end":"2026-04-28T18:12:12.226237Z","steps":["trace[2072705054] 'process raft request' (duration: 165.834093ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.226439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.522249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/persistence-rabbitmq-manila-server-0.18aa97d179cbf408\" ","response":"range_response_count:1 size:1010"} {"level":"info","ts":"2026-04-28T18:12:12.22651Z","caller":"traceutil/trace.go:171","msg":"trace[1554750675] range","detail":"{range_begin:/registry/events/openstack/persistence-rabbitmq-manila-server-0.18aa97d179cbf408; range_end:; response_count:1; response_revision:25302; }","duration":"173.640931ms","start":"2026-04-28T18:12:12.052851Z","end":"2026-04-28T18:12:12.226492Z","steps":["trace[1554750675] 'agreement among raft nodes before linearized reading' (duration: 173.452077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.41077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.321744ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:12.411045Z","caller":"traceutil/trace.go:171","msg":"trace[1763954461] transaction","detail":"{read_only:false; response_revision:25303; number_of_response:1; }","duration":"183.452379ms","start":"2026-04-28T18:12:12.227569Z","end":"2026-04-28T18:12:12.411021Z","steps":["trace[1763954461] 'process raft request' (duration: 79.781749ms)","trace[1763954461] 'compare' (duration: 103.046638ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:12.411246Z","caller":"traceutil/trace.go:171","msg":"trace[2094452022] linearizableReadLoop","detail":"{readStateIndex:26115; appliedIndex:26113; }","duration":"179.900497ms","start":"2026-04-28T18:12:12.231327Z","end":"2026-04-28T18:12:12.411228Z","steps":["trace[2094452022] 'read index received' (duration: 75.968452ms)","trace[2094452022] 'applied index is now lower than readState.Index' (duration: 103.931065ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:12.411259Z","caller":"traceutil/trace.go:171","msg":"trace[82247268] transaction","detail":"{read_only:false; response_revision:25304; number_of_response:1; }","duration":"181.074441ms","start":"2026-04-28T18:12:12.230154Z","end":"2026-04-28T18:12:12.411228Z","steps":["trace[82247268] 'process raft request' (duration: 180.829186ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:12.411301Z","caller":"traceutil/trace.go:171","msg":"trace[985354324] transaction","detail":"{read_only:false; response_revision:25305; number_of_response:1; }","duration":"135.307528ms","start":"2026-04-28T18:12:12.275972Z","end":"2026-04-28T18:12:12.411279Z","steps":["trace[985354324] 'process raft request' (duration: 135.114724ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.411547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.192643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1446"} {"level":"info","ts":"2026-04-28T18:12:12.411626Z","caller":"traceutil/trace.go:171","msg":"trace[1096894295] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25305; }","duration":"180.337836ms","start":"2026-04-28T18:12:12.23127Z","end":"2026-04-28T18:12:12.411608Z","steps":["trace[1096894295] 'agreement among raft nodes before linearized reading' (duration: 180.06099ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.411706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.516729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5684"} {"level":"info","ts":"2026-04-28T18:12:12.41179Z","caller":"traceutil/trace.go:171","msg":"trace[1670340613] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25305; }","duration":"176.599451ms","start":"2026-04-28T18:12:12.235173Z","end":"2026-04-28T18:12:12.411773Z","steps":["trace[1670340613] 'agreement among raft nodes before linearized reading' (duration: 176.328265ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:12.727875Z","caller":"traceutil/trace.go:171","msg":"trace[1994736899] transaction","detail":"{read_only:false; response_revision:25306; number_of_response:1; }","duration":"311.345678ms","start":"2026-04-28T18:12:12.416506Z","end":"2026-04-28T18:12:12.727851Z","steps":["trace[1994736899] 'process raft request' (duration: 311.198465ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.728097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:12.416487Z","time spent":"311.45429ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:12.753086Z","caller":"traceutil/trace.go:171","msg":"trace[148166697] linearizableReadLoop","detail":"{readStateIndex:26118; appliedIndex:26116; }","duration":"330.510024ms","start":"2026-04-28T18:12:12.422552Z","end":"2026-04-28T18:12:12.753062Z","steps":["trace[148166697] 'read index received' (duration: 305.145793ms)","trace[148166697] 'applied index is now lower than readState.Index' (duration: 25.360111ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:12.753137Z","caller":"traceutil/trace.go:171","msg":"trace[748041755] transaction","detail":"{read_only:false; response_revision:25307; number_of_response:1; }","duration":"336.023645ms","start":"2026-04-28T18:12:12.417088Z","end":"2026-04-28T18:12:12.753111Z","steps":["trace[748041755] 'process raft request' (duration: 335.863102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.753277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.718888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9600"} {"level":"info","ts":"2026-04-28T18:12:12.753331Z","caller":"traceutil/trace.go:171","msg":"trace[702784045] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25307; }","duration":"330.80059ms","start":"2026-04-28T18:12:12.422516Z","end":"2026-04-28T18:12:12.753317Z","steps":["trace[702784045] 'agreement among raft nodes before linearized reading' (duration: 330.625317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:12.753341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:12.41706Z","time spent":"336.177729ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:12.753382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:12.422502Z","time spent":"330.868241ms","remote":"127.0.0.1:53076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":9623,"request content":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" "} {"level":"warn","ts":"2026-04-28T18:12:13.114447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.139269ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:13.114538Z","caller":"traceutil/trace.go:171","msg":"trace[1296512010] linearizableReadLoop","detail":"{readStateIndex:26119; appliedIndex:26118; }","duration":"352.072669ms","start":"2026-04-28T18:12:12.762449Z","end":"2026-04-28T18:12:13.114521Z","steps":["trace[1296512010] 'read index received' (duration: 133.763057ms)","trace[1296512010] 'applied index is now lower than readState.Index' (duration: 218.308242ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:13.114579Z","caller":"traceutil/trace.go:171","msg":"trace[151951074] transaction","detail":"{read_only:false; response_revision:25308; number_of_response:1; }","duration":"354.078169ms","start":"2026-04-28T18:12:12.760476Z","end":"2026-04-28T18:12:13.114554Z","steps":["trace[151951074] 'process raft request' (duration: 135.749046ms)","trace[151951074] 'compare' (duration: 217.979116ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:13.114638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.182741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:12:13.114681Z","caller":"traceutil/trace.go:171","msg":"trace[1333930003] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25308; }","duration":"352.240623ms","start":"2026-04-28T18:12:12.762429Z","end":"2026-04-28T18:12:13.11467Z","steps":["trace[1333930003] 'agreement among raft nodes before linearized reading' (duration: 352.166471ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:13.11472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:12.76242Z","time spent":"352.291554ms","remote":"127.0.0.1:52640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T18:12:13.114738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:12.760458Z","time spent":"354.173491ms","remote":"127.0.0.1:52714","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":729,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:13.193075Z","caller":"traceutil/trace.go:171","msg":"trace[1262799906] transaction","detail":"{read_only:false; response_revision:25309; number_of_response:1; }","duration":"169.115609ms","start":"2026-04-28T18:12:13.02394Z","end":"2026-04-28T18:12:13.193055Z","steps":["trace[1262799906] 'process raft request' (duration: 168.962436ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:13.193227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.313612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-28T18:12:13.193335Z","caller":"traceutil/trace.go:171","msg":"trace[984998111] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:25309; }","duration":"216.458464ms","start":"2026-04-28T18:12:12.97685Z","end":"2026-04-28T18:12:13.193309Z","steps":["trace[984998111] 'agreement among raft nodes before linearized reading' (duration: 216.25038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:13.193455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.365237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/messaging-topology-operator-leader-election\" ","response":"range_response_count:1 size:574"} {"level":"info","ts":"2026-04-28T18:12:13.193556Z","caller":"traceutil/trace.go:171","msg":"trace[1918668871] range","detail":"{range_begin:/registry/leases/openstack/messaging-topology-operator-leader-election; range_end:; response_count:1; response_revision:25309; }","duration":"180.510039ms","start":"2026-04-28T18:12:13.01302Z","end":"2026-04-28T18:12:13.19353Z","steps":["trace[1918668871] 'agreement among raft nodes before linearized reading' (duration: 180.204793ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:13.193666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.05787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-04-28T18:12:13.193739Z","caller":"traceutil/trace.go:171","msg":"trace[707837488] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25309; }","duration":"181.141932ms","start":"2026-04-28T18:12:13.012582Z","end":"2026-04-28T18:12:13.193724Z","steps":["trace[707837488] 'agreement among raft nodes before linearized reading' (duration: 180.970868ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:18.489107Z","caller":"traceutil/trace.go:171","msg":"trace[176686364] transaction","detail":"{read_only:false; response_revision:25364; number_of_response:1; }","duration":"320.522474ms","start":"2026-04-28T18:12:18.168551Z","end":"2026-04-28T18:12:18.489074Z","steps":["trace[176686364] 'process raft request' (duration: 320.32903ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:18.489515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:18.16853Z","time spent":"320.658746ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:18.510396Z","caller":"traceutil/trace.go:171","msg":"trace[842420333] linearizableReadLoop","detail":"{readStateIndex:26179; appliedIndex:26176; }","duration":"221.311112ms","start":"2026-04-28T18:12:18.289062Z","end":"2026-04-28T18:12:18.510373Z","steps":["trace[842420333] 'read index received' (duration: 199.756909ms)","trace[842420333] 'applied index is now lower than readState.Index' (duration: 21.553533ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:18.510498Z","caller":"traceutil/trace.go:171","msg":"trace[1473145500] transaction","detail":"{read_only:false; response_revision:25366; number_of_response:1; }","duration":"269.611155ms","start":"2026-04-28T18:12:18.240875Z","end":"2026-04-28T18:12:18.510486Z","steps":["trace[1473145500] 'process raft request' (duration: 269.461082ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:18.51049Z","caller":"traceutil/trace.go:171","msg":"trace[1595623096] transaction","detail":"{read_only:false; response_revision:25365; number_of_response:1; }","duration":"275.744349ms","start":"2026-04-28T18:12:18.234713Z","end":"2026-04-28T18:12:18.510458Z","steps":["trace[1595623096] 'process raft request' (duration: 275.495304ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:18.510596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.544331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbuckets/\" range_end:\"/registry/objectbucket.io/objectbuckets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:12:18.510641Z","caller":"traceutil/trace.go:171","msg":"trace[935525323] range","detail":"{range_begin:/registry/objectbucket.io/objectbuckets/; range_end:/registry/objectbucket.io/objectbuckets0; response_count:0; response_revision:25366; }","duration":"188.645633ms","start":"2026-04-28T18:12:18.321982Z","end":"2026-04-28T18:12:18.510627Z","steps":["trace[935525323] 'agreement among raft nodes before linearized reading' (duration: 188.557991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:18.5109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.820952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclusters/openstack/ceph\" ","response":"range_response_count:1 size:7698"} {"level":"info","ts":"2026-04-28T18:12:18.510983Z","caller":"traceutil/trace.go:171","msg":"trace[1064506361] range","detail":"{range_begin:/registry/ceph.rook.io/cephclusters/openstack/ceph; range_end:; response_count:1; response_revision:25366; }","duration":"221.962246ms","start":"2026-04-28T18:12:18.289001Z","end":"2026-04-28T18:12:18.510963Z","steps":["trace[1064506361] 'agreement among raft nodes before linearized reading' (duration: 221.573487ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:18.711012Z","caller":"traceutil/trace.go:171","msg":"trace[1916977402] transaction","detail":"{read_only:false; response_revision:25367; number_of_response:1; }","duration":"191.637795ms","start":"2026-04-28T18:12:18.519352Z","end":"2026-04-28T18:12:18.71099Z","steps":["trace[1916977402] 'process raft request' (duration: 191.477972ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:18.711819Z","caller":"traceutil/trace.go:171","msg":"trace[469973512] linearizableReadLoop","detail":"{readStateIndex:26181; appliedIndex:26179; }","duration":"111.708453ms","start":"2026-04-28T18:12:18.600091Z","end":"2026-04-28T18:12:18.7118Z","steps":["trace[469973512] 'read index received' (duration: 110.809795ms)","trace[469973512] 'applied index is now lower than readState.Index' (duration: 897.668µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:18.712002Z","caller":"traceutil/trace.go:171","msg":"trace[1991308634] transaction","detail":"{read_only:false; response_revision:25368; number_of_response:1; }","duration":"165.355154ms","start":"2026-04-28T18:12:18.546626Z","end":"2026-04-28T18:12:18.711981Z","steps":["trace[1991308634] 'process raft request' (duration: 165.031728ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:18.712554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.444717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-04-28T18:12:18.712616Z","caller":"traceutil/trace.go:171","msg":"trace[778875906] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25368; }","duration":"112.55322ms","start":"2026-04-28T18:12:18.600046Z","end":"2026-04-28T18:12:18.712599Z","steps":["trace[778875906] 'agreement among raft nodes before linearized reading' (duration: 111.829835ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:49.059536Z","caller":"traceutil/trace.go:171","msg":"trace[1585942141] linearizableReadLoop","detail":"{readStateIndex:26433; appliedIndex:26432; }","duration":"118.05646ms","start":"2026-04-28T18:12:48.941448Z","end":"2026-04-28T18:12:49.059504Z","steps":["trace[1585942141] 'read index received' (duration: 117.821076ms)","trace[1585942141] 'applied index is now lower than readState.Index' (duration: 234.064µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:49.059635Z","caller":"traceutil/trace.go:171","msg":"trace[1600234233] transaction","detail":"{read_only:false; response_revision:25613; number_of_response:1; }","duration":"118.685812ms","start":"2026-04-28T18:12:48.94092Z","end":"2026-04-28T18:12:49.059605Z","steps":["trace[1600234233] 'process raft request' (duration: 118.359426ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:49.059795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.322015ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-28T18:12:49.059862Z","caller":"traceutil/trace.go:171","msg":"trace[404558573] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25613; }","duration":"118.427667ms","start":"2026-04-28T18:12:48.941414Z","end":"2026-04-28T18:12:49.059842Z","steps":["trace[404558573] 'agreement among raft nodes before linearized reading' (duration: 118.210723ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:49.065661Z","caller":"traceutil/trace.go:171","msg":"trace[1181642678] transaction","detail":"{read_only:false; response_revision:25614; number_of_response:1; }","duration":"102.699731ms","start":"2026-04-28T18:12:48.962937Z","end":"2026-04-28T18:12:49.065637Z","steps":["trace[1181642678] 'process raft request' (duration: 102.587279ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:49.788486Z","caller":"traceutil/trace.go:171","msg":"trace[1143676345] linearizableReadLoop","detail":"{readStateIndex:26439; appliedIndex:26438; }","duration":"231.413076ms","start":"2026-04-28T18:12:49.557057Z","end":"2026-04-28T18:12:49.78847Z","steps":["trace[1143676345] 'read index received' (duration: 231.228962ms)","trace[1143676345] 'applied index is now lower than readState.Index' (duration: 183.504µs)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:49.788554Z","caller":"traceutil/trace.go:171","msg":"trace[593071683] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"250.111783ms","start":"2026-04-28T18:12:49.538424Z","end":"2026-04-28T18:12:49.788536Z","steps":["trace[593071683] 'process raft request' (duration: 249.908759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:49.788659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.276331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-28T18:12:49.788697Z","caller":"traceutil/trace.go:171","msg":"trace[185159586] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25619; }","duration":"221.358173ms","start":"2026-04-28T18:12:49.567327Z","end":"2026-04-28T18:12:49.788685Z","steps":["trace[185159586] 'agreement among raft nodes before linearized reading' (duration: 221.244641ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:49.788891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.789384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-28T18:12:49.789019Z","caller":"traceutil/trace.go:171","msg":"trace[1195303545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25619; }","duration":"231.982397ms","start":"2026-04-28T18:12:49.557009Z","end":"2026-04-28T18:12:49.788991Z","steps":["trace[1195303545] 'agreement among raft nodes before linearized reading' (duration: 231.575829ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:50.088833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.315391ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:50.08955Z","caller":"traceutil/trace.go:171","msg":"trace[503999607] transaction","detail":"{read_only:false; response_revision:25622; number_of_response:1; }","duration":"172.58347ms","start":"2026-04-28T18:12:49.916943Z","end":"2026-04-28T18:12:50.089526Z","steps":["trace[503999607] 'process raft request' (duration: 21.436943ms)","trace[503999607] 'compare' (duration: 149.852512ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:50.102939Z","caller":"traceutil/trace.go:171","msg":"trace[1760937507] linearizableReadLoop","detail":"{readStateIndex:26443; appliedIndex:26442; }","duration":"106.784273ms","start":"2026-04-28T18:12:49.99613Z","end":"2026-04-28T18:12:50.102914Z","steps":["trace[1760937507] 'read index received' (duration: 106.64513ms)","trace[1760937507] 'applied index is now lower than readState.Index' (duration: 138.013µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:50.103234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.056558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-28T18:12:50.103258Z","caller":"traceutil/trace.go:171","msg":"trace[1626374781] transaction","detail":"{read_only:false; response_revision:25623; number_of_response:1; }","duration":"161.880034ms","start":"2026-04-28T18:12:49.941342Z","end":"2026-04-28T18:12:50.103222Z","steps":["trace[1626374781] 'process raft request' (duration: 161.458056ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:50.103293Z","caller":"traceutil/trace.go:171","msg":"trace[1721767674] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25623; }","duration":"107.209951ms","start":"2026-04-28T18:12:49.99607Z","end":"2026-04-28T18:12:50.10328Z","steps":["trace[1721767674] 'agreement among raft nodes before linearized reading' (duration: 106.939816ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:50.224367Z","caller":"traceutil/trace.go:171","msg":"trace[1341841065] transaction","detail":"{read_only:false; response_revision:25624; number_of_response:1; }","duration":"116.402056ms","start":"2026-04-28T18:12:50.107923Z","end":"2026-04-28T18:12:50.224325Z","steps":["trace[1341841065] 'process raft request' (duration: 114.724793ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:50.951511Z","caller":"traceutil/trace.go:171","msg":"trace[1990197385] transaction","detail":"{read_only:false; response_revision:25625; number_of_response:1; }","duration":"301.471099ms","start":"2026-04-28T18:12:50.650023Z","end":"2026-04-28T18:12:50.951494Z","steps":["trace[1990197385] 'process raft request' (duration: 301.362117ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:50.951624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:50.649998Z","time spent":"301.56795ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:51.116405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.524303ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:51.116616Z","caller":"traceutil/trace.go:171","msg":"trace[647214873] linearizableReadLoop","detail":"{readStateIndex:26447; appliedIndex:26444; }","duration":"222.051198ms","start":"2026-04-28T18:12:50.894548Z","end":"2026-04-28T18:12:51.116599Z","steps":["trace[647214873] 'read index received' (duration: 56.827307ms)","trace[647214873] 'applied index is now lower than readState.Index' (duration: 165.222711ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:51.116782Z","caller":"traceutil/trace.go:171","msg":"trace[444890141] transaction","detail":"{read_only:false; response_revision:25626; number_of_response:1; }","duration":"465.766622ms","start":"2026-04-28T18:12:50.650984Z","end":"2026-04-28T18:12:51.116751Z","steps":["trace[444890141] 'process raft request' (duration: 328.80164ms)","trace[444890141] 'compare' (duration: 136.282909ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:51.116835Z","caller":"traceutil/trace.go:171","msg":"trace[807980613] transaction","detail":"{read_only:false; response_revision:25627; number_of_response:1; }","duration":"465.369503ms","start":"2026-04-28T18:12:50.651436Z","end":"2026-04-28T18:12:51.116805Z","steps":["trace[807980613] 'process raft request' (duration: 465.073417ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:51.11696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:50.651431Z","time spent":"465.463305ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:51.117033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:50.650964Z","time spent":"465.940785ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:51.116968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.399825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.125\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-04-28T18:12:51.117215Z","caller":"traceutil/trace.go:171","msg":"trace[1415893122] range","detail":"{range_begin:/registry/masterleases/199.19.213.125; range_end:; response_count:1; response_revision:25627; }","duration":"222.684341ms","start":"2026-04-28T18:12:50.894506Z","end":"2026-04-28T18:12:51.11719Z","steps":["trace[1415893122] 'agreement among raft nodes before linearized reading' (duration: 222.191571ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:51.276635Z","caller":"traceutil/trace.go:171","msg":"trace[1866002714] transaction","detail":"{read_only:false; response_revision:25628; number_of_response:1; }","duration":"155.018346ms","start":"2026-04-28T18:12:51.121592Z","end":"2026-04-28T18:12:51.27661Z","steps":["trace[1866002714] 'process raft request' (duration: 154.802162ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:51.276783Z","caller":"traceutil/trace.go:171","msg":"trace[778247807] transaction","detail":"{read_only:false; response_revision:25629; number_of_response:1; }","duration":"154.220029ms","start":"2026-04-28T18:12:51.122496Z","end":"2026-04-28T18:12:51.276716Z","steps":["trace[778247807] 'process raft request' (duration: 154.032795ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:51.444121Z","caller":"traceutil/trace.go:171","msg":"trace[684271116] transaction","detail":"{read_only:false; response_revision:25631; number_of_response:1; }","duration":"126.518312ms","start":"2026-04-28T18:12:51.317578Z","end":"2026-04-28T18:12:51.444096Z","steps":["trace[684271116] 'process raft request' (duration: 126.315478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:51.720911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.91678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:51.72102Z","caller":"traceutil/trace.go:171","msg":"trace[1810349954] transaction","detail":"{read_only:false; response_revision:25633; number_of_response:1; }","duration":"271.740389ms","start":"2026-04-28T18:12:51.44926Z","end":"2026-04-28T18:12:51.721001Z","steps":["trace[1810349954] 'process raft request' (duration: 132.626245ms)","trace[1810349954] 'compare' (duration: 138.790118ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:52.001091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.141896ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:52.0012Z","caller":"traceutil/trace.go:171","msg":"trace[1279226802] linearizableReadLoop","detail":"{readStateIndex:26455; appliedIndex:26454; }","duration":"200.40283ms","start":"2026-04-28T18:12:51.800779Z","end":"2026-04-28T18:12:52.001182Z","steps":["trace[1279226802] 'read index received' (duration: 56.01974ms)","trace[1279226802] 'applied index is now lower than readState.Index' (duration: 144.38128ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:52.001324Z","caller":"traceutil/trace.go:171","msg":"trace[538017210] transaction","detail":"{read_only:false; response_revision:25634; number_of_response:1; }","duration":"206.968312ms","start":"2026-04-28T18:12:51.794315Z","end":"2026-04-28T18:12:52.001283Z","steps":["trace[538017210] 'process raft request' (duration: 62.540811ms)","trace[538017210] 'compare' (duration: 143.87494ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:52.001539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.760698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-28T18:12:52.001582Z","caller":"traceutil/trace.go:171","msg":"trace[574925246] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25634; }","duration":"200.83376ms","start":"2026-04-28T18:12:51.800735Z","end":"2026-04-28T18:12:52.001569Z","steps":["trace[574925246] 'agreement among raft nodes before linearized reading' (duration: 200.702097ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:52.001622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.512346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-28T18:12:52.001681Z","caller":"traceutil/trace.go:171","msg":"trace[136286587] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25634; }","duration":"156.604148ms","start":"2026-04-28T18:12:51.845059Z","end":"2026-04-28T18:12:52.001663Z","steps":["trace[136286587] 'agreement among raft nodes before linearized reading' (duration: 156.446985ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:52.388146Z","caller":"traceutil/trace.go:171","msg":"trace[340425823] transaction","detail":"{read_only:false; response_revision:25636; number_of_response:1; }","duration":"381.283799ms","start":"2026-04-28T18:12:52.006835Z","end":"2026-04-28T18:12:52.388118Z","steps":["trace[340425823] 'process raft request' (duration: 381.148326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:52.38827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:52.006802Z","time spent":"381.401771ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:52.425712Z","caller":"traceutil/trace.go:171","msg":"trace[1707105054] linearizableReadLoop","detail":"{readStateIndex:26458; appliedIndex:26456; }","duration":"196.346879ms","start":"2026-04-28T18:12:52.229346Z","end":"2026-04-28T18:12:52.425692Z","steps":["trace[1707105054] 'read index received' (duration: 158.723811ms)","trace[1707105054] 'applied index is now lower than readState.Index' (duration: 37.621918ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:52.425938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.581413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-04-28T18:12:52.426008Z","caller":"traceutil/trace.go:171","msg":"trace[1026780935] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25637; }","duration":"196.703936ms","start":"2026-04-28T18:12:52.229288Z","end":"2026-04-28T18:12:52.425992Z","steps":["trace[1026780935] 'agreement among raft nodes before linearized reading' (duration: 196.490432ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:52.426355Z","caller":"traceutil/trace.go:171","msg":"trace[1715667480] transaction","detail":"{read_only:false; response_revision:25637; number_of_response:1; }","duration":"332.634797ms","start":"2026-04-28T18:12:52.093708Z","end":"2026-04-28T18:12:52.426342Z","steps":["trace[1715667480] 'process raft request' (duration: 331.889862ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:52.426444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:52.093687Z","time spent":"332.703149ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:52.702105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.84745ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:52.702462Z","caller":"traceutil/trace.go:171","msg":"trace[1781020089] linearizableReadLoop","detail":"{readStateIndex:26459; appliedIndex:26458; }","duration":"154.586627ms","start":"2026-04-28T18:12:52.547855Z","end":"2026-04-28T18:12:52.702442Z","steps":["trace[1781020089] 'read index received' (duration: 8.288108ms)","trace[1781020089] 'applied index is now lower than readState.Index' (duration: 146.296329ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:52.702529Z","caller":"traceutil/trace.go:171","msg":"trace[1279511309] transaction","detail":"{read_only:false; response_revision:25638; number_of_response:1; }","duration":"269.717528ms","start":"2026-04-28T18:12:52.432734Z","end":"2026-04-28T18:12:52.702451Z","steps":["trace[1279511309] 'process raft request' (duration: 123.434179ms)","trace[1279511309] 'compare' (duration: 145.710228ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:52.702854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.977854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:186"} {"level":"info","ts":"2026-04-28T18:12:52.703256Z","caller":"traceutil/trace.go:171","msg":"trace[878613222] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:25638; }","duration":"155.26455ms","start":"2026-04-28T18:12:52.547788Z","end":"2026-04-28T18:12:52.703053Z","steps":["trace[878613222] 'agreement among raft nodes before linearized reading' (duration: 154.835692ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:53.254408Z","caller":"traceutil/trace.go:171","msg":"trace[590183733] transaction","detail":"{read_only:false; response_revision:25641; number_of_response:1; }","duration":"132.172875ms","start":"2026-04-28T18:12:53.122189Z","end":"2026-04-28T18:12:53.254362Z","steps":["trace[590183733] 'process raft request' (duration: 121.812106ms)","trace[590183733] 'compare' (duration: 10.035643ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:53.517503Z","caller":"traceutil/trace.go:171","msg":"trace[1012979864] linearizableReadLoop","detail":"{readStateIndex:26463; appliedIndex:26461; }","duration":"382.206557ms","start":"2026-04-28T18:12:53.13528Z","end":"2026-04-28T18:12:53.517487Z","steps":["trace[1012979864] 'read index received' (duration: 108.645281ms)","trace[1012979864] 'applied index is now lower than readState.Index' (duration: 273.560596ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:53.517605Z","caller":"traceutil/trace.go:171","msg":"trace[1186667279] transaction","detail":"{read_only:false; response_revision:25642; number_of_response:1; }","duration":"394.885311ms","start":"2026-04-28T18:12:53.122711Z","end":"2026-04-28T18:12:53.517596Z","steps":["trace[1186667279] 'process raft request' (duration: 356.785003ms)","trace[1186667279] 'compare' (duration: 37.845583ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:53.517678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.1237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinesets/\" range_end:\"/registry/cluster.x-k8s.io/machinesets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-28T18:12:53.517698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:53.122687Z","time spent":"394.936933ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:53.517732Z","caller":"traceutil/trace.go:171","msg":"trace[1736841861] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinesets/; range_end:/registry/cluster.x-k8s.io/machinesets0; response_count:0; response_revision:25643; }","duration":"287.223182ms","start":"2026-04-28T18:12:53.230495Z","end":"2026-04-28T18:12:53.517718Z","steps":["trace[1736841861] 'agreement among raft nodes before linearized reading' (duration: 287.11385ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:53.517954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.262789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"} {"level":"warn","ts":"2026-04-28T18:12:53.517974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.464658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-04-28T18:12:53.51802Z","caller":"traceutil/trace.go:171","msg":"trace[1694053995] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25643; }","duration":"236.522909ms","start":"2026-04-28T18:12:53.281474Z","end":"2026-04-28T18:12:53.517997Z","steps":["trace[1694053995] 'agreement among raft nodes before linearized reading' (duration: 236.430527ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:53.518024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.746328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-04-28T18:12:53.518053Z","caller":"traceutil/trace.go:171","msg":"trace[2127915271] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25643; }","duration":"382.791118ms","start":"2026-04-28T18:12:53.135247Z","end":"2026-04-28T18:12:53.518038Z","steps":["trace[2127915271] 'agreement among raft nodes before linearized reading' (duration: 382.635105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:53.518075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:53.135236Z","time spent":"382.83262ms","remote":"127.0.0.1:52808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-04-28T18:12:53.517982Z","caller":"traceutil/trace.go:171","msg":"trace[999115764] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:25643; }","duration":"149.334081ms","start":"2026-04-28T18:12:53.368639Z","end":"2026-04-28T18:12:53.517973Z","steps":["trace[999115764] 'agreement among raft nodes before linearized reading' (duration: 149.245229ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:53.518248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.469429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"warn","ts":"2026-04-28T18:12:53.51834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.91189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/cilium\" ","response":"range_response_count:1 size:521"} {"level":"info","ts":"2026-04-28T18:12:53.518372Z","caller":"traceutil/trace.go:171","msg":"trace[1553178722] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/cilium; range_end:; response_count:1; response_revision:25643; }","duration":"134.958291ms","start":"2026-04-28T18:12:53.383405Z","end":"2026-04-28T18:12:53.518363Z","steps":["trace[1553178722] 'agreement among raft nodes before linearized reading' (duration: 134.858779ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:53.518388Z","caller":"traceutil/trace.go:171","msg":"trace[873561593] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25643; }","duration":"237.648431ms","start":"2026-04-28T18:12:53.28071Z","end":"2026-04-28T18:12:53.518359Z","steps":["trace[873561593] 'agreement among raft nodes before linearized reading' (duration: 237.208703ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:53.677542Z","caller":"traceutil/trace.go:171","msg":"trace[340107159] transaction","detail":"{read_only:false; response_revision:25644; number_of_response:1; }","duration":"154.373753ms","start":"2026-04-28T18:12:53.523132Z","end":"2026-04-28T18:12:53.677506Z","steps":["trace[340107159] 'process raft request' (duration: 127.00129ms)","trace[340107159] 'compare' (duration: 26.947254ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:53.677852Z","caller":"traceutil/trace.go:171","msg":"trace[1061004532] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"154.371143ms","start":"2026-04-28T18:12:53.52345Z","end":"2026-04-28T18:12:53.677821Z","steps":["trace[1061004532] 'process raft request' (duration: 153.950054ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:53.67806Z","caller":"traceutil/trace.go:171","msg":"trace[466796132] linearizableReadLoop","detail":"{readStateIndex:26467; appliedIndex:26464; }","duration":"153.945164ms","start":"2026-04-28T18:12:53.524052Z","end":"2026-04-28T18:12:53.677998Z","steps":["trace[466796132] 'read index received' (duration: 126.172114ms)","trace[466796132] 'applied index is now lower than readState.Index' (duration: 27.77073ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:53.678174Z","caller":"traceutil/trace.go:171","msg":"trace[108209384] transaction","detail":"{read_only:false; response_revision:25646; number_of_response:1; }","duration":"154.588667ms","start":"2026-04-28T18:12:53.523523Z","end":"2026-04-28T18:12:53.678112Z","steps":["trace[108209384] 'process raft request' (duration: 154.196489ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:53.678313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.207729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18256"} {"level":"info","ts":"2026-04-28T18:12:53.678465Z","caller":"traceutil/trace.go:171","msg":"trace[974938939] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25646; }","duration":"154.316391ms","start":"2026-04-28T18:12:53.524033Z","end":"2026-04-28T18:12:53.678349Z","steps":["trace[974938939] 'agreement among raft nodes before linearized reading' (duration: 154.116537ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:53.678499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.681068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-3b3bbdcd-b1ea-44e0-8d1d-c74fdc7e8470\" ","response":"range_response_count:1 size:1322"} {"level":"info","ts":"2026-04-28T18:12:53.678567Z","caller":"traceutil/trace.go:171","msg":"trace[1676333102] range","detail":"{range_begin:/registry/persistentvolumes/pvc-3b3bbdcd-b1ea-44e0-8d1d-c74fdc7e8470; range_end:; response_count:1; response_revision:25646; }","duration":"151.734789ms","start":"2026-04-28T18:12:53.526802Z","end":"2026-04-28T18:12:53.678536Z","steps":["trace[1676333102] 'agreement among raft nodes before linearized reading' (duration: 151.581216ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:54.166835Z","caller":"traceutil/trace.go:171","msg":"trace[622201599] linearizableReadLoop","detail":"{readStateIndex:26470; appliedIndex:26469; }","duration":"102.6695ms","start":"2026-04-28T18:12:54.064144Z","end":"2026-04-28T18:12:54.166813Z","steps":["trace[622201599] 'read index received' (duration: 102.470365ms)","trace[622201599] 'applied index is now lower than readState.Index' (duration: 198.245µs)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:54.167059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.895345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-28T18:12:54.1671Z","caller":"traceutil/trace.go:171","msg":"trace[141038055] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25649; }","duration":"102.983817ms","start":"2026-04-28T18:12:54.064105Z","end":"2026-04-28T18:12:54.167089Z","steps":["trace[141038055] 'agreement among raft nodes before linearized reading' (duration: 102.805143ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:54.167392Z","caller":"traceutil/trace.go:171","msg":"trace[430286150] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"160.002366ms","start":"2026-04-28T18:12:54.007372Z","end":"2026-04-28T18:12:54.167374Z","steps":["trace[430286150] 'process raft request' (duration: 159.308992ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:54.468411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.620486ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:54.468611Z","caller":"traceutil/trace.go:171","msg":"trace[607500544] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"295.700622ms","start":"2026-04-28T18:12:54.172885Z","end":"2026-04-28T18:12:54.468585Z","steps":["trace[607500544] 'process raft request' (duration: 88.835861ms)","trace[607500544] 'compare' (duration: 206.526504ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:54.874854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.660973ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-28T18:12:54.875004Z","caller":"traceutil/trace.go:171","msg":"trace[1809378414] transaction","detail":"{read_only:false; response_revision:25651; number_of_response:1; }","duration":"442.845219ms","start":"2026-04-28T18:12:54.432134Z","end":"2026-04-28T18:12:54.874979Z","steps":["trace[1809378414] 'process raft request' (duration: 257.957661ms)","trace[1809378414] 'compare' (duration: 184.528751ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:54.875088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:54.432105Z","time spent":"442.941111ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-28T18:12:55.160005Z","caller":"traceutil/trace.go:171","msg":"trace[970129465] transaction","detail":"{read_only:false; response_revision:25652; number_of_response:1; }","duration":"687.168494ms","start":"2026-04-28T18:12:54.472802Z","end":"2026-04-28T18:12:55.159971Z","steps":["trace[970129465] 'process raft request' (duration: 666.909686ms)","trace[970129465] 'compare' (duration: 19.969802ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:55.160064Z","caller":"traceutil/trace.go:171","msg":"trace[1887200332] transaction","detail":"{read_only:false; response_revision:25653; number_of_response:1; }","duration":"170.784633ms","start":"2026-04-28T18:12:54.989263Z","end":"2026-04-28T18:12:55.160048Z","steps":["trace[1887200332] 'process raft request' (duration: 170.714502ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:55.160088Z","caller":"traceutil/trace.go:171","msg":"trace[1007470499] linearizableReadLoop","detail":"{readStateIndex:26473; appliedIndex:26471; }","duration":"568.457732ms","start":"2026-04-28T18:12:54.591608Z","end":"2026-04-28T18:12:55.160066Z","steps":["trace[1007470499] 'read index received' (duration: 98.618749ms)","trace[1007470499] 'applied index is now lower than readState.Index' (duration: 469.836083ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:55.160154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:54.472787Z","time spent":"687.293597ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-28T18:12:55.16021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.596134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-28T18:12:55.160236Z","caller":"traceutil/trace.go:171","msg":"trace[149904382] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:25653; }","duration":"568.671996ms","start":"2026-04-28T18:12:54.591554Z","end":"2026-04-28T18:12:55.160226Z","steps":["trace[149904382] 'agreement among raft nodes before linearized reading' (duration: 568.616175ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:55.160253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:54.591534Z","time spent":"568.713566ms","remote":"127.0.0.1:46642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "} {"level":"warn","ts":"2026-04-28T18:12:55.160301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.520735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-28T18:12:55.160341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.725347ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-04-28T18:12:55.160375Z","caller":"traceutil/trace.go:171","msg":"trace[1925868439] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25653; }","duration":"397.635248ms","start":"2026-04-28T18:12:54.762721Z","end":"2026-04-28T18:12:55.160356Z","steps":["trace[1925868439] 'agreement among raft nodes before linearized reading' (duration: 397.525265ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:55.160392Z","caller":"traceutil/trace.go:171","msg":"trace[1195007536] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25653; }","duration":"452.813479ms","start":"2026-04-28T18:12:54.707561Z","end":"2026-04-28T18:12:55.160375Z","steps":["trace[1195007536] 'agreement among raft nodes before linearized reading' (duration: 452.654276ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:55.160422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:54.762702Z","time spent":"397.712149ms","remote":"127.0.0.1:52640","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-04-28T18:12:55.160429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-28T18:12:54.70754Z","time spent":"452.881971ms","remote":"127.0.0.1:52900","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-28T18:12:55.402526Z","caller":"traceutil/trace.go:171","msg":"trace[903278891] transaction","detail":"{read_only:false; response_revision:25655; number_of_response:1; }","duration":"142.487813ms","start":"2026-04-28T18:12:55.260017Z","end":"2026-04-28T18:12:55.402504Z","steps":["trace[903278891] 'process raft request' (duration: 137.743317ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:55.632967Z","caller":"traceutil/trace.go:171","msg":"trace[1313200276] transaction","detail":"{read_only:false; response_revision:25656; number_of_response:1; }","duration":"108.539198ms","start":"2026-04-28T18:12:55.524405Z","end":"2026-04-28T18:12:55.632944Z","steps":["trace[1313200276] 'process raft request' (duration: 49.627891ms)","trace[1313200276] 'compare' (duration: 58.744464ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:55.792273Z","caller":"traceutil/trace.go:171","msg":"trace[985044924] linearizableReadLoop","detail":"{readStateIndex:26478; appliedIndex:26477; }","duration":"109.600709ms","start":"2026-04-28T18:12:55.682637Z","end":"2026-04-28T18:12:55.792238Z","steps":["trace[985044924] 'read index received' (duration: 80.736787ms)","trace[985044924] 'applied index is now lower than readState.Index' (duration: 28.862832ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:55.792382Z","caller":"traceutil/trace.go:171","msg":"trace[1113314296] transaction","detail":"{read_only:false; response_revision:25657; number_of_response:1; }","duration":"266.101256ms","start":"2026-04-28T18:12:55.526245Z","end":"2026-04-28T18:12:55.792346Z","steps":["trace[1113314296] 'process raft request' (duration: 237.124171ms)","trace[1113314296] 'compare' (duration: 28.75083ms)"],"step_count":2} {"level":"warn","ts":"2026-04-28T18:12:55.792513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.781413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-04-28T18:12:55.792525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.864695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-04-28T18:12:55.792572Z","caller":"traceutil/trace.go:171","msg":"trace[166616996] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25657; }","duration":"109.880795ms","start":"2026-04-28T18:12:55.68268Z","end":"2026-04-28T18:12:55.792561Z","steps":["trace[166616996] 'agreement among raft nodes before linearized reading' (duration: 109.715372ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:55.792593Z","caller":"traceutil/trace.go:171","msg":"trace[2019294743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25657; }","duration":"109.979947ms","start":"2026-04-28T18:12:55.682598Z","end":"2026-04-28T18:12:55.792578Z","steps":["trace[2019294743] 'agreement among raft nodes before linearized reading' (duration: 109.762963ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:55.792618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.737882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:12:55.792662Z","caller":"traceutil/trace.go:171","msg":"trace[302326478] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25657; }","duration":"104.813304ms","start":"2026-04-28T18:12:55.687836Z","end":"2026-04-28T18:12:55.792649Z","steps":["trace[302326478] 'agreement among raft nodes before linearized reading' (duration: 104.717482ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:55.792751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.025148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-04-28T18:12:55.792809Z","caller":"traceutil/trace.go:171","msg":"trace[775585346] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25657; }","duration":"109.10829ms","start":"2026-04-28T18:12:55.683683Z","end":"2026-04-28T18:12:55.792791Z","steps":["trace[775585346] 'agreement among raft nodes before linearized reading' (duration: 108.909016ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:55.975637Z","caller":"traceutil/trace.go:171","msg":"trace[381049526] transaction","detail":"{read_only:false; response_revision:25659; number_of_response:1; }","duration":"178.671413ms","start":"2026-04-28T18:12:55.796935Z","end":"2026-04-28T18:12:55.975607Z","steps":["trace[381049526] 'process raft request' (duration: 108.199972ms)","trace[381049526] 'compare' (duration: 70.262897ms)"],"step_count":2} {"level":"info","ts":"2026-04-28T18:12:55.975861Z","caller":"traceutil/trace.go:171","msg":"trace[1545214043] transaction","detail":"{read_only:false; response_revision:25660; number_of_response:1; }","duration":"178.910988ms","start":"2026-04-28T18:12:55.79693Z","end":"2026-04-28T18:12:55.975842Z","steps":["trace[1545214043] 'process raft request' (duration: 178.622522ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:55.975922Z","caller":"traceutil/trace.go:171","msg":"trace[525567636] transaction","detail":"{read_only:false; response_revision:25661; number_of_response:1; }","duration":"177.111211ms","start":"2026-04-28T18:12:55.798795Z","end":"2026-04-28T18:12:55.975906Z","steps":["trace[525567636] 'process raft request' (duration: 176.960478ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:12:56.343242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.765576ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-28T18:12:56.343641Z","caller":"traceutil/trace.go:171","msg":"trace[57165180] transaction","detail":"{read_only:false; response_revision:25662; number_of_response:1; }","duration":"169.917946ms","start":"2026-04-28T18:12:56.173703Z","end":"2026-04-28T18:12:56.343621Z","steps":["trace[57165180] 'process raft request' (duration: 169.668851ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:12:57.541807Z","caller":"traceutil/trace.go:171","msg":"trace[201894486] transaction","detail":"{read_only:false; response_revision:25668; number_of_response:1; }","duration":"134.007993ms","start":"2026-04-28T18:12:57.40778Z","end":"2026-04-28T18:12:57.541788Z","steps":["trace[201894486] 'process raft request' (duration: 133.87806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-28T18:13:01.967033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.803348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-28T18:13:01.967118Z","caller":"traceutil/trace.go:171","msg":"trace[1443242578] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:25699; }","duration":"130.93646ms","start":"2026-04-28T18:13:01.836162Z","end":"2026-04-28T18:13:01.967098Z","steps":["trace[1443242578] 'count revisions from in-memory index tree' (duration: 130.736157ms)"],"step_count":1} {"level":"info","ts":"2026-04-28T18:13:21.271952Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-00000000000068be.wal"} {"level":"info","ts":"2026-04-28T18:14:17.667234Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23467} {"level":"info","ts":"2026-04-28T18:14:17.824061Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23467,"took":"153.330581ms","hash":1687913250,"current-db-size-bytes":58404864,"current-db-size":"58 MB","current-db-size-in-use-bytes":37695488,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-04-28T18:14:17.824158Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1687913250,"revision":23467,"compact-revision":20418} {"level":"info","ts":"2026-04-28T18:19:07.10908Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-28T18:19:07.115072Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-04-28T18:19:07.115189Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-04-28T18:19:17.678748Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26499} {"level":"info","ts":"2026-04-28T18:19:17.836541Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26499,"took":"152.425874ms","hash":2598051493,"current-db-size-bytes":59670528,"current-db-size":"60 MB","current-db-size-in-use-bytes":35192832,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-04-28T18:19:17.83664Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2598051493,"revision":26499,"compact-revision":23467} {"level":"info","ts":"2026-04-28T18:24:17.684601Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":29166} {"level":"info","ts":"2026-04-28T18:24:17.818672Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":29166,"took":"129.642059ms","hash":2972650714,"current-db-size-bytes":59670528,"current-db-size":"60 MB","current-db-size-in-use-bytes":30998528,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-28T18:24:17.818736Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2972650714,"revision":29166,"compact-revision":26499} {"level":"info","ts":"2026-04-28T18:29:17.691467Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31427} {"level":"info","ts":"2026-04-28T18:29:17.825645Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31427,"took":"129.566218ms","hash":1181062052,"current-db-size-bytes":59670528,"current-db-size":"60 MB","current-db-size-in-use-bytes":31305728,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-28T18:29:17.825727Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1181062052,"revision":31427,"compact-revision":29166} {"level":"info","ts":"2026-04-28T18:34:17.697292Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33762} {"level":"info","ts":"2026-04-28T18:34:17.853998Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33762,"took":"152.003112ms","hash":3164749685,"current-db-size-bytes":60710912,"current-db-size":"61 MB","current-db-size-in-use-bytes":33247232,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-28T18:34:17.85408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3164749685,"revision":33762,"compact-revision":31427} {"level":"info","ts":"2026-04-28T18:39:17.704115Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":36005} {"level":"info","ts":"2026-04-28T18:39:17.845108Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":36005,"took":"134.677952ms","hash":3752150771,"current-db-size-bytes":64172032,"current-db-size":"64 MB","current-db-size-in-use-bytes":33275904,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-28T18:39:17.845182Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3752150771,"revision":36005,"compact-revision":33762} {"level":"info","ts":"2026-04-28T18:40:11.221021Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b448fdce642f2755","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-28T18:40:11.226065Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-04-28T18:40:11.226168Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}