{"level":"warn","ts":"2026-04-04T10:15:17.901232Z","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-04T10:15:17.901314Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.74:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.74:2380","--initial-cluster=instance=https://199.204.45.74:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.74:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.74: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-04T10:15:17.901379Z","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-04T10:15:17.901388Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-04T10:15:17.901405Z","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-04T10:15:17.902127Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"]} {"level":"info","ts":"2026-04-04T10:15:17.902202Z","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.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.74: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-04T10:15:17.906437Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.981263ms"} {"level":"info","ts":"2026-04-04T10:15:17.912961Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"89ba38f964b95aa0","cluster-id":"54492f71bf65c400"} {"level":"info","ts":"2026-04-04T10:15:17.91308Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=()"} {"level":"info","ts":"2026-04-04T10:15:17.913116Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 0"} {"level":"info","ts":"2026-04-04T10:15:17.913147Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 89ba38f964b95aa0 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-04T10:15:17.913162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became follower at term 1"} {"level":"info","ts":"2026-04-04T10:15:17.913215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"warn","ts":"2026-04-04T10:15:17.919797Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-04T10:15:17.921379Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-04T10:15:17.922356Z","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-04T10:15:17.926918Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"89ba38f964b95aa0","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-04T10:15:17.927624Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"89ba38f964b95aa0","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-04T10:15:17.927701Z","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-04T10:15:17.92785Z","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-04T10:15:17.927863Z","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-04T10:15:17.930035Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 switched to configuration voters=(9924307372652190368)"} {"level":"info","ts":"2026-04-04T10:15:17.930143Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","added-peer-id":"89ba38f964b95aa0","added-peer-peer-urls":["https://199.204.45.74:2380"]} {"level":"info","ts":"2026-04-04T10:15:17.932036Z","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-04T10:15:17.932128Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-04T10:15:17.932158Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.74:2380"} {"level":"info","ts":"2026-04-04T10:15:17.932272Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"89ba38f964b95aa0","initial-advertise-peer-urls":["https://199.204.45.74:2380"],"listen-peer-urls":["https://199.204.45.74:2380"],"advertise-client-urls":["https://199.204.45.74:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.74:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-04T10:15:17.932315Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-04T10:15:18.613887Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 is starting a new election at term 1"} {"level":"info","ts":"2026-04-04T10:15:18.613946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-04T10:15:18.613966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgPreVoteResp from 89ba38f964b95aa0 at term 1"} {"level":"info","ts":"2026-04-04T10:15:18.613978Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became candidate at term 2"} {"level":"info","ts":"2026-04-04T10:15:18.613984Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 received MsgVoteResp from 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-04T10:15:18.613994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"89ba38f964b95aa0 became leader at term 2"} {"level":"info","ts":"2026-04-04T10:15:18.614001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 89ba38f964b95aa0 elected leader 89ba38f964b95aa0 at term 2"} {"level":"info","ts":"2026-04-04T10:15:18.61542Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"89ba38f964b95aa0","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.74:2379]}","request-path":"/0/members/89ba38f964b95aa0/attributes","cluster-id":"54492f71bf65c400","publish-timeout":"7s"} {"level":"info","ts":"2026-04-04T10:15:18.615533Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-04T10:15:18.615503Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:15:18.615614Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-04T10:15:18.617181Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"54492f71bf65c400","local-member-id":"89ba38f964b95aa0","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:15:18.617312Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:15:18.617343Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-04T10:15:18.617751Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-04T10:15:18.618198Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.74:2379"} {"level":"info","ts":"2026-04-04T10:15:18.624246Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-04T10:15:18.624309Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-04T10:15:30.337305Z","caller":"traceutil/trace.go:171","msg":"trace[2143617441] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"249.71941ms","start":"2026-04-04T10:15:30.08756Z","end":"2026-04-04T10:15:30.337279Z","steps":["trace[2143617441] 'process raft request' (duration: 249.591277ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:30.548088Z","caller":"traceutil/trace.go:171","msg":"trace[1053219132] linearizableReadLoop","detail":"{readStateIndex:405; appliedIndex:404; }","duration":"159.623359ms","start":"2026-04-04T10:15:30.388439Z","end":"2026-04-04T10:15:30.548062Z","steps":["trace[1053219132] 'read index received' (duration: 159.366682ms)","trace[1053219132] 'applied index is now lower than readState.Index' (duration: 255.547µs)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:15:30.548153Z","caller":"traceutil/trace.go:171","msg":"trace[220186935] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"199.096037ms","start":"2026-04-04T10:15:30.349023Z","end":"2026-04-04T10:15:30.548119Z","steps":["trace[220186935] 'process raft request' (duration: 198.885331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:15:30.548226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.772714ms","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-04T10:15:30.548458Z","caller":"traceutil/trace.go:171","msg":"trace[1993743780] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:393; }","duration":"160.044142ms","start":"2026-04-04T10:15:30.388392Z","end":"2026-04-04T10:15:30.548436Z","steps":["trace[1993743780] 'agreement among raft nodes before linearized reading' (duration: 159.770354ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:15:30.836559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.72653ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:15:30.836854Z","caller":"traceutil/trace.go:171","msg":"trace[1299746236] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"283.923769ms","start":"2026-04-04T10:15:30.552898Z","end":"2026-04-04T10:15:30.836822Z","steps":["trace[1299746236] 'process raft request' (duration: 127.179331ms)","trace[1299746236] 'compare' (duration: 155.575066ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:15:30.836957Z","caller":"traceutil/trace.go:171","msg":"trace[499661939] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"280.867922ms","start":"2026-04-04T10:15:30.556065Z","end":"2026-04-04T10:15:30.836933Z","steps":["trace[499661939] 'process raft request' (duration: 280.623626ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:30.837043Z","caller":"traceutil/trace.go:171","msg":"trace[1834828618] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"278.763113ms","start":"2026-04-04T10:15:30.558261Z","end":"2026-04-04T10:15:30.837024Z","steps":["trace[1834828618] 'process raft request' (duration: 278.514756ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:30.837157Z","caller":"traceutil/trace.go:171","msg":"trace[1135256586] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:405; }","duration":"195.040971ms","start":"2026-04-04T10:15:30.642074Z","end":"2026-04-04T10:15:30.837115Z","steps":["trace[1135256586] 'read index received' (duration: 38.003885ms)","trace[1135256586] 'applied index is now lower than readState.Index' (duration: 157.035046ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:15:30.837276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.195536ms","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-04T10:15:30.837305Z","caller":"traceutil/trace.go:171","msg":"trace[1872385001] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:397; }","duration":"195.277769ms","start":"2026-04-04T10:15:30.642018Z","end":"2026-04-04T10:15:30.837296Z","steps":["trace[1872385001] 'agreement among raft nodes before linearized reading' (duration: 195.200916ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:30.837295Z","caller":"traceutil/trace.go:171","msg":"trace[1207139073] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"277.302172ms","start":"2026-04-04T10:15:30.559976Z","end":"2026-04-04T10:15:30.837278Z","steps":["trace[1207139073] 'process raft request' (duration: 276.845399ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.874424Z","caller":"traceutil/trace.go:171","msg":"trace[1448617259] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"103.877379ms","start":"2026-04-04T10:15:48.770518Z","end":"2026-04-04T10:15:48.874396Z","steps":["trace[1448617259] 'process raft request' (duration: 102.977773ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882322Z","caller":"traceutil/trace.go:171","msg":"trace[1144719324] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"110.791877ms","start":"2026-04-04T10:15:48.771515Z","end":"2026-04-04T10:15:48.882307Z","steps":["trace[1144719324] 'process raft request' (duration: 110.707764ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882357Z","caller":"traceutil/trace.go:171","msg":"trace[1052891070] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"111.134787ms","start":"2026-04-04T10:15:48.771201Z","end":"2026-04-04T10:15:48.882336Z","steps":["trace[1052891070] 'process raft request' (duration: 110.985012ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882325Z","caller":"traceutil/trace.go:171","msg":"trace[1756964418] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"111.652171ms","start":"2026-04-04T10:15:48.770635Z","end":"2026-04-04T10:15:48.882287Z","steps":["trace[1756964418] 'process raft request' (duration: 111.449225ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882482Z","caller":"traceutil/trace.go:171","msg":"trace[1457556443] transaction","detail":"{read_only:false; number_of_response:1; response_revision:516; }","duration":"108.715907ms","start":"2026-04-04T10:15:48.773745Z","end":"2026-04-04T10:15:48.882461Z","steps":["trace[1457556443] 'process raft request' (duration: 108.565043ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882449Z","caller":"traceutil/trace.go:171","msg":"trace[2113360190] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"110.640082ms","start":"2026-04-04T10:15:48.771747Z","end":"2026-04-04T10:15:48.882387Z","steps":["trace[2113360190] 'process raft request' (duration: 110.502208ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882529Z","caller":"traceutil/trace.go:171","msg":"trace[1624736946] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"107.791631ms","start":"2026-04-04T10:15:48.774692Z","end":"2026-04-04T10:15:48.882484Z","steps":["trace[1624736946] 'process raft request' (duration: 107.659977ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882591Z","caller":"traceutil/trace.go:171","msg":"trace[1405559524] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"107.707408ms","start":"2026-04-04T10:15:48.774873Z","end":"2026-04-04T10:15:48.88258Z","steps":["trace[1405559524] 'process raft request' (duration: 107.510253ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882629Z","caller":"traceutil/trace.go:171","msg":"trace[5190003] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"104.99034ms","start":"2026-04-04T10:15:48.777622Z","end":"2026-04-04T10:15:48.882613Z","steps":["trace[5190003] 'process raft request' (duration: 104.894208ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882644Z","caller":"traceutil/trace.go:171","msg":"trace[1698893703] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"107.651787ms","start":"2026-04-04T10:15:48.774935Z","end":"2026-04-04T10:15:48.882587Z","steps":["trace[1698893703] 'process raft request' (duration: 107.478102ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.882779Z","caller":"traceutil/trace.go:171","msg":"trace[1778274972] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"102.224671ms","start":"2026-04-04T10:15:48.780516Z","end":"2026-04-04T10:15:48.882741Z","steps":["trace[1778274972] 'process raft request' (duration: 102.049616ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:48.883112Z","caller":"traceutil/trace.go:171","msg":"trace[1190429761] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"109.005435ms","start":"2026-04-04T10:15:48.773427Z","end":"2026-04-04T10:15:48.882432Z","steps":["trace[1190429761] 'process raft request' (duration: 108.847021ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:55.107568Z","caller":"traceutil/trace.go:171","msg":"trace[1437698807] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"133.719431ms","start":"2026-04-04T10:15:54.973824Z","end":"2026-04-04T10:15:55.107544Z","steps":["trace[1437698807] 'process raft request' (duration: 133.584687ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:55.183148Z","caller":"traceutil/trace.go:171","msg":"trace[864568681] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"205.596755ms","start":"2026-04-04T10:15:54.977527Z","end":"2026-04-04T10:15:55.183123Z","steps":["trace[864568681] 'process raft request' (duration: 205.216344ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:55.189173Z","caller":"traceutil/trace.go:171","msg":"trace[850915270] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"122.245984ms","start":"2026-04-04T10:15:55.066892Z","end":"2026-04-04T10:15:55.189138Z","steps":["trace[850915270] 'process raft request' (duration: 116.339585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:15:55.373741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.517064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-898tz\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-04T10:15:55.373852Z","caller":"traceutil/trace.go:171","msg":"trace[1523433624] range","detail":"{range_begin:/registry/pods/kube-system/cilium-898tz; range_end:; response_count:1; response_revision:617; }","duration":"232.679928ms","start":"2026-04-04T10:15:55.141148Z","end":"2026-04-04T10:15:55.373828Z","steps":["trace[1523433624] 'agreement among raft nodes before linearized reading' (duration: 47.95462ms)","trace[1523433624] 'range keys from in-memory index tree' (duration: 184.491472ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:15:55.460445Z","caller":"traceutil/trace.go:171","msg":"trace[1027166202] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"208.649573ms","start":"2026-04-04T10:15:55.251772Z","end":"2026-04-04T10:15:55.460421Z","steps":["trace[1027166202] 'process raft request' (duration: 208.511759ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:55.588836Z","caller":"traceutil/trace.go:171","msg":"trace[982811859] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:640; }","duration":"115.075478ms","start":"2026-04-04T10:15:55.473731Z","end":"2026-04-04T10:15:55.588806Z","steps":["trace[982811859] 'read index received' (duration: 43.552854ms)","trace[982811859] 'applied index is now lower than readState.Index' (duration: 71.521674ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:15:55.588979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.222132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:15:55.58895Z","caller":"traceutil/trace.go:171","msg":"trace[172402044] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"193.496949ms","start":"2026-04-04T10:15:55.395421Z","end":"2026-04-04T10:15:55.588918Z","steps":["trace[172402044] 'process raft request' (duration: 121.946644ms)","trace[172402044] 'compare' (duration: 71.291068ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:15:55.589019Z","caller":"traceutil/trace.go:171","msg":"trace[12036022] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:619; }","duration":"115.316855ms","start":"2026-04-04T10:15:55.473688Z","end":"2026-04-04T10:15:55.589005Z","steps":["trace[12036022] 'agreement among raft nodes before linearized reading' (duration: 115.230412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:15:56.137844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.010364ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:15:56.137956Z","caller":"traceutil/trace.go:171","msg":"trace[1139250593] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"157.883472ms","start":"2026-04-04T10:15:55.980054Z","end":"2026-04-04T10:15:56.137938Z","steps":["trace[1139250593] 'read index received' (duration: 44.751µs)","trace[1139250593] 'applied index is now lower than readState.Index' (duration: 157.837551ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:15:56.138029Z","caller":"traceutil/trace.go:171","msg":"trace[678290373] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"471.063331ms","start":"2026-04-04T10:15:55.666956Z","end":"2026-04-04T10:15:56.138019Z","steps":["trace[678290373] 'process raft request' (duration: 79.7891ms)","trace[678290373] 'compare' (duration: 390.88448ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:15:56.138094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:15:55.666934Z","time spent":"471.131133ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:15:56.138177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.096418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:15:56.138289Z","caller":"traceutil/trace.go:171","msg":"trace[1780425877] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"158.251082ms","start":"2026-04-04T10:15:55.980011Z","end":"2026-04-04T10:15:56.138263Z","steps":["trace[1780425877] 'agreement among raft nodes before linearized reading' (duration: 158.085778ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:15:56.45715Z","caller":"traceutil/trace.go:171","msg":"trace[1090786957] linearizableReadLoop","detail":"{readStateIndex:643; appliedIndex:642; }","duration":"319.14435ms","start":"2026-04-04T10:15:56.137983Z","end":"2026-04-04T10:15:56.457127Z","steps":["trace[1090786957] 'read index received' (duration: 317.932145ms)","trace[1090786957] 'applied index is now lower than readState.Index' (duration: 1.211255ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:15:56.457258Z","caller":"traceutil/trace.go:171","msg":"trace[1216211942] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"474.787248ms","start":"2026-04-04T10:15:55.982429Z","end":"2026-04-04T10:15:56.457216Z","steps":["trace[1216211942] 'process raft request' (duration: 473.728467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:15:56.457448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.530664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:15:56.457496Z","caller":"traceutil/trace.go:171","msg":"trace[107241415] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"317.701189ms","start":"2026-04-04T10:15:56.139782Z","end":"2026-04-04T10:15:56.457483Z","steps":["trace[107241415] 'agreement among raft nodes before linearized reading' (duration: 317.551105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:15:56.457497Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:15:55.982384Z","time spent":"474.974263ms","remote":"127.0.0.1:49024","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:15:56.457502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.788022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-04-04T10:15:56.45756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:15:56.13976Z","time spent":"317.788411ms","remote":"127.0.0.1:48950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-04T10:15:56.457597Z","caller":"traceutil/trace.go:171","msg":"trace[1825123096] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"387.944926ms","start":"2026-04-04T10:15:56.069631Z","end":"2026-04-04T10:15:56.457575Z","steps":["trace[1825123096] 'agreement among raft nodes before linearized reading' (duration: 387.594246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:15:56.457657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:15:56.069596Z","time spent":"388.048859ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-04-04T10:16:15.434398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.75428ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:16:15.434515Z","caller":"traceutil/trace.go:171","msg":"trace[1653798155] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"217.112004ms","start":"2026-04-04T10:16:15.217386Z","end":"2026-04-04T10:16:15.434498Z","steps":["trace[1653798155] 'read index received' (duration: 18.284863ms)","trace[1653798155] 'applied index is now lower than readState.Index' (duration: 198.825791ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:16:15.434606Z","caller":"traceutil/trace.go:171","msg":"trace[728032381] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"308.834695ms","start":"2026-04-04T10:16:15.125761Z","end":"2026-04-04T10:16:15.434596Z","steps":["trace[728032381] 'process raft request' (duration: 109.792548ms)","trace[728032381] 'compare' (duration: 198.600495ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:16:15.434663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:16:15.125733Z","time spent":"308.899467ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:16:15.434845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.282102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4fvcm\" ","response":"range_response_count:1 size:3964"} {"level":"warn","ts":"2026-04-04T10:16:15.434932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.536126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-04-04T10:16:15.434932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.515498ms","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-04T10:16:15.434942Z","caller":"traceutil/trace.go:171","msg":"trace[557750966] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-4fvcm; range_end:; response_count:1; response_revision:791; }","duration":"186.407716ms","start":"2026-04-04T10:16:15.248504Z","end":"2026-04-04T10:16:15.434912Z","steps":["trace[557750966] 'agreement among raft nodes before linearized reading' (duration: 186.154789ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:16:15.434988Z","caller":"traceutil/trace.go:171","msg":"trace[940650983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:791; }","duration":"217.63321ms","start":"2026-04-04T10:16:15.217337Z","end":"2026-04-04T10:16:15.43497Z","steps":["trace[940650983] 'agreement among raft nodes before linearized reading' (duration: 217.456145ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:16:15.435003Z","caller":"traceutil/trace.go:171","msg":"trace[892716470] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"138.605561ms","start":"2026-04-04T10:16:15.296373Z","end":"2026-04-04T10:16:15.434979Z","steps":["trace[892716470] 'agreement among raft nodes before linearized reading' (duration: 138.431326ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:17:00.950176Z","caller":"traceutil/trace.go:171","msg":"trace[1571112652] transaction","detail":"{read_only:false; response_revision:1328; number_of_response:1; }","duration":"112.508376ms","start":"2026-04-04T10:17:00.837641Z","end":"2026-04-04T10:17:00.950149Z","steps":["trace[1571112652] 'process raft request' (duration: 112.34433ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:17:07.684169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.427464ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:17:07.684483Z","caller":"traceutil/trace.go:171","msg":"trace[1974502281] transaction","detail":"{read_only:false; response_revision:1459; number_of_response:1; }","duration":"142.895603ms","start":"2026-04-04T10:17:07.541544Z","end":"2026-04-04T10:17:07.68444Z","steps":["trace[1974502281] 'process raft request' (duration: 24.064158ms)","trace[1974502281] 'compare' (duration: 118.244869ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:17:30.748425Z","caller":"traceutil/trace.go:171","msg":"trace[606060672] linearizableReadLoop","detail":"{readStateIndex:1914; appliedIndex:1913; }","duration":"118.689972ms","start":"2026-04-04T10:17:30.629715Z","end":"2026-04-04T10:17:30.748405Z","steps":["trace[606060672] 'read index received' (duration: 118.608899ms)","trace[606060672] 'applied index is now lower than readState.Index' (duration: 80.443µs)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:17:30.748568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.851007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-080ea156-d558-4a6e-96e8-ca9c1ce87335\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-04T10:17:30.748602Z","caller":"traceutil/trace.go:171","msg":"trace[1164680966] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-080ea156-d558-4a6e-96e8-ca9c1ce87335; range_end:; response_count:1; response_revision:1842; }","duration":"118.921689ms","start":"2026-04-04T10:17:30.62966Z","end":"2026-04-04T10:17:30.748581Z","steps":["trace[1164680966] 'agreement among raft nodes before linearized reading' (duration: 118.817585ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:17:30.748736Z","caller":"traceutil/trace.go:171","msg":"trace[82547777] transaction","detail":"{read_only:false; response_revision:1842; number_of_response:1; }","duration":"136.737938ms","start":"2026-04-04T10:17:30.611969Z","end":"2026-04-04T10:17:30.748707Z","steps":["trace[82547777] 'process raft request' (duration: 136.340136ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:17:31.204706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.289005ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:17:31.204995Z","caller":"traceutil/trace.go:171","msg":"trace[1140651534] transaction","detail":"{read_only:false; response_revision:1845; number_of_response:1; }","duration":"317.519793ms","start":"2026-04-04T10:17:30.887439Z","end":"2026-04-04T10:17:31.204959Z","steps":["trace[1140651534] 'process raft request' (duration: 317.39736ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:17:31.205074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:17:30.887412Z","time spent":"317.627007ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:17:31.205132Z","caller":"traceutil/trace.go:171","msg":"trace[1337708862] linearizableReadLoop","detail":"{readStateIndex:1916; appliedIndex:1915; }","duration":"398.120767ms","start":"2026-04-04T10:17:30.806959Z","end":"2026-04-04T10:17:31.205079Z","steps":["trace[1337708862] 'read index received' (duration: 240.346798ms)","trace[1337708862] 'applied index is now lower than readState.Index' (duration: 157.765568ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:17:31.205219Z","caller":"traceutil/trace.go:171","msg":"trace[291233873] transaction","detail":"{read_only:false; response_revision:1844; number_of_response:1; }","duration":"414.897037ms","start":"2026-04-04T10:17:30.790281Z","end":"2026-04-04T10:17:31.205178Z","steps":["trace[291233873] 'process raft request' (duration: 257.019955ms)","trace[291233873] 'compare' (duration: 157.034828ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:17:31.205476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:17:30.790246Z","time spent":"415.073762ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-04T10:17:31.205663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"398.690423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-04T10:17:31.205722Z","caller":"traceutil/trace.go:171","msg":"trace[1752888297] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1845; }","duration":"398.788626ms","start":"2026-04-04T10:17:30.806914Z","end":"2026-04-04T10:17:31.205702Z","steps":["trace[1752888297] 'agreement among raft nodes before linearized reading' (duration: 398.478988ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:17:31.205747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.35293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-04T10:17:31.20577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:17:30.806898Z","time spent":"398.861649ms","remote":"127.0.0.1:53762","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5467,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-04-04T10:17:31.205827Z","caller":"traceutil/trace.go:171","msg":"trace[1835048042] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1845; }","duration":"225.470013ms","start":"2026-04-04T10:17:30.980339Z","end":"2026-04-04T10:17:31.205809Z","steps":["trace[1835048042] 'agreement among raft nodes before linearized reading' (duration: 225.34351ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:17:31.205802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.723878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:17:31.205911Z","caller":"traceutil/trace.go:171","msg":"trace[1894757385] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1845; }","duration":"290.913903ms","start":"2026-04-04T10:17:30.914972Z","end":"2026-04-04T10:17:31.205885Z","steps":["trace[1894757385] 'agreement among raft nodes before linearized reading' (duration: 290.704848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:17:31.205837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.661339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-04T10:17:31.206014Z","caller":"traceutil/trace.go:171","msg":"trace[73437519] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1845; }","duration":"113.869095ms","start":"2026-04-04T10:17:31.092128Z","end":"2026-04-04T10:17:31.205997Z","steps":["trace[73437519] 'agreement among raft nodes before linearized reading' (duration: 113.546425ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:18:15.593098Z","caller":"traceutil/trace.go:171","msg":"trace[1393209144] transaction","detail":"{read_only:false; response_revision:2144; number_of_response:1; }","duration":"128.024035ms","start":"2026-04-04T10:18:15.465027Z","end":"2026-04-04T10:18:15.593051Z","steps":["trace[1393209144] 'process raft request' (duration: 127.919753ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:18:15.594625Z","caller":"traceutil/trace.go:171","msg":"trace[1177187083] transaction","detail":"{read_only:false; response_revision:2143; number_of_response:1; }","duration":"132.805321ms","start":"2026-04-04T10:18:15.460244Z","end":"2026-04-04T10:18:15.593049Z","steps":["trace[1177187083] 'process raft request' (duration: 33.712618ms)","trace[1177187083] 'compare' (duration: 98.785375ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:18:21.789585Z","caller":"traceutil/trace.go:171","msg":"trace[136962127] transaction","detail":"{read_only:false; response_revision:2174; number_of_response:1; }","duration":"151.301287ms","start":"2026-04-04T10:18:21.638261Z","end":"2026-04-04T10:18:21.789563Z","steps":["trace[136962127] 'process raft request' (duration: 151.092661ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:18:21.828994Z","caller":"traceutil/trace.go:171","msg":"trace[661942858] linearizableReadLoop","detail":"{readStateIndex:2258; appliedIndex:2256; }","duration":"180.361392ms","start":"2026-04-04T10:18:21.64861Z","end":"2026-04-04T10:18:21.828971Z","steps":["trace[661942858] 'read index received' (duration: 140.775078ms)","trace[661942858] 'applied index is now lower than readState.Index' (duration: 39.585484ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:18:21.829276Z","caller":"traceutil/trace.go:171","msg":"trace[1879665037] transaction","detail":"{read_only:false; response_revision:2175; number_of_response:1; }","duration":"188.313558ms","start":"2026-04-04T10:18:21.640947Z","end":"2026-04-04T10:18:21.829261Z","steps":["trace[1879665037] 'process raft request' (duration: 187.908706ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:18:21.829669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.025752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-04-04T10:18:21.829756Z","caller":"traceutil/trace.go:171","msg":"trace[1717047896] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2175; }","duration":"181.144404ms","start":"2026-04-04T10:18:21.648584Z","end":"2026-04-04T10:18:21.829729Z","steps":["trace[1717047896] 'agreement among raft nodes before linearized reading' (duration: 180.867867ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:19:14.238273Z","caller":"traceutil/trace.go:171","msg":"trace[109986667] linearizableReadLoop","detail":"{readStateIndex:2731; appliedIndex:2730; }","duration":"144.626903ms","start":"2026-04-04T10:19:14.09361Z","end":"2026-04-04T10:19:14.238237Z","steps":["trace[109986667] 'read index received' (duration: 144.368366ms)","trace[109986667] 'applied index is now lower than readState.Index' (duration: 257.327µs)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:19:14.238351Z","caller":"traceutil/trace.go:171","msg":"trace[1731334370] transaction","detail":"{read_only:false; response_revision:2628; number_of_response:1; }","duration":"194.659426ms","start":"2026-04-04T10:19:14.043661Z","end":"2026-04-04T10:19:14.238321Z","steps":["trace[1731334370] 'process raft request' (duration: 194.377018ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:19:14.238604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.872991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-04T10:19:14.238706Z","caller":"traceutil/trace.go:171","msg":"trace[1420812494] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:2628; }","duration":"145.100747ms","start":"2026-04-04T10:19:14.093567Z","end":"2026-04-04T10:19:14.238668Z","steps":["trace[1420812494] 'agreement among raft nodes before linearized reading' (duration: 144.85251ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:19:14.238725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.675505ms","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-04T10:19:14.238824Z","caller":"traceutil/trace.go:171","msg":"trace[1568816810] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2628; }","duration":"144.820949ms","start":"2026-04-04T10:19:14.093976Z","end":"2026-04-04T10:19:14.238797Z","steps":["trace[1568816810] 'agreement among raft nodes before linearized reading' (duration: 144.489149ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:19:48.188251Z","caller":"traceutil/trace.go:171","msg":"trace[112199298] transaction","detail":"{read_only:false; response_revision:2831; number_of_response:1; }","duration":"265.354736ms","start":"2026-04-04T10:19:47.922863Z","end":"2026-04-04T10:19:48.188218Z","steps":["trace[112199298] 'process raft request' (duration: 265.12519ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:19:48.263175Z","caller":"traceutil/trace.go:171","msg":"trace[189047597] transaction","detail":"{read_only:false; response_revision:2832; number_of_response:1; }","duration":"313.65598ms","start":"2026-04-04T10:19:47.949488Z","end":"2026-04-04T10:19:48.263144Z","steps":["trace[189047597] 'process raft request' (duration: 305.975541ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:19:48.263345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:19:47.949466Z","time spent":"313.794833ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:23:46.62336Z","caller":"traceutil/trace.go:171","msg":"trace[1100112767] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"116.534391ms","start":"2026-04-04T10:23:46.5068Z","end":"2026-04-04T10:23:46.623334Z","steps":["trace[1100112767] 'process raft request' (duration: 116.249203ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:23:48.928681Z","caller":"traceutil/trace.go:171","msg":"trace[1185332616] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"132.198216ms","start":"2026-04-04T10:23:48.796452Z","end":"2026-04-04T10:23:48.92865Z","steps":["trace[1185332616] 'process raft request' (duration: 119.289688ms)","trace[1185332616] 'compare' (duration: 12.780314ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:23:49.892604Z","caller":"traceutil/trace.go:171","msg":"trace[1574615913] linearizableReadLoop","detail":"{readStateIndex:5100; appliedIndex:5099; }","duration":"131.325181ms","start":"2026-04-04T10:23:49.76125Z","end":"2026-04-04T10:23:49.892576Z","steps":["trace[1574615913] 'read index received' (duration: 131.163247ms)","trace[1574615913] 'applied index is now lower than readState.Index' (duration: 160.784µs)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:23:49.892626Z","caller":"traceutil/trace.go:171","msg":"trace[1747590611] transaction","detail":"{read_only:false; response_revision:4909; number_of_response:1; }","duration":"154.990776ms","start":"2026-04-04T10:23:49.737604Z","end":"2026-04-04T10:23:49.892595Z","steps":["trace[1747590611] 'process raft request' (duration: 154.822031ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:23:49.899157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.875558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:50 size:2196036"} {"level":"info","ts":"2026-04-04T10:23:49.899507Z","caller":"traceutil/trace.go:171","msg":"trace[1603623355] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:50; response_revision:4909; }","duration":"138.102634ms","start":"2026-04-04T10:23:49.761204Z","end":"2026-04-04T10:23:49.899307Z","steps":["trace[1603623355] 'agreement among raft nodes before linearized reading' (duration: 131.522887ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:23:54.859484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.987363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:23:54.859647Z","caller":"traceutil/trace.go:171","msg":"trace[1159721143] transaction","detail":"{read_only:false; response_revision:5102; number_of_response:1; }","duration":"228.284543ms","start":"2026-04-04T10:23:54.631337Z","end":"2026-04-04T10:23:54.859621Z","steps":["trace[1159721143] 'process raft request' (duration: 111.054213ms)","trace[1159721143] 'compare' (duration: 116.827189ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:23:55.261319Z","caller":"traceutil/trace.go:171","msg":"trace[1506400658] transaction","detail":"{read_only:false; response_revision:5103; number_of_response:1; }","duration":"611.225493ms","start":"2026-04-04T10:23:54.650033Z","end":"2026-04-04T10:23:55.261258Z","steps":["trace[1506400658] 'process raft request' (duration: 549.450753ms)","trace[1506400658] 'compare' (duration: 61.480091ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:23:55.261496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:23:54.65Z","time spent":"611.407188ms","remote":"127.0.0.1:58040","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":413790,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:23:55.261666Z","caller":"traceutil/trace.go:171","msg":"trace[1073398261] transaction","detail":"{read_only:false; response_revision:5104; number_of_response:1; }","duration":"571.247934ms","start":"2026-04-04T10:23:54.690387Z","end":"2026-04-04T10:23:55.261635Z","steps":["trace[1073398261] 'process raft request' (duration: 570.798111ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:23:55.261677Z","caller":"traceutil/trace.go:171","msg":"trace[1081479455] linearizableReadLoop","detail":"{readStateIndex:5300; appliedIndex:5297; }","duration":"534.702192ms","start":"2026-04-04T10:23:54.726941Z","end":"2026-04-04T10:23:55.261643Z","steps":["trace[1081479455] 'read index received' (duration: 15.416199ms)","trace[1081479455] 'applied index is now lower than readState.Index' (duration: 519.281813ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:23:55.261809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:23:54.690366Z","time spent":"571.380277ms","remote":"127.0.0.1:48038","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1813,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-04T10:23:55.261982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"535.025722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f907392-34f7-44ec-bc8b-30530b72cd48\" ","response":"range_response_count:1 size:3717"} {"level":"warn","ts":"2026-04-04T10:23:55.26196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.391409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-04T10:23:55.261974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.973785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:23:55.26203Z","caller":"traceutil/trace.go:171","msg":"trace[121261864] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-4f907392-34f7-44ec-bc8b-30530b72cd48; range_end:; response_count:1; response_revision:5105; }","duration":"535.133305ms","start":"2026-04-04T10:23:54.726882Z","end":"2026-04-04T10:23:55.262015Z","steps":["trace[121261864] 'agreement among raft nodes before linearized reading' (duration: 534.915129ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:23:55.262052Z","caller":"traceutil/trace.go:171","msg":"trace[336467473] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5105; }","duration":"281.086978ms","start":"2026-04-04T10:23:54.980947Z","end":"2026-04-04T10:23:55.262034Z","steps":["trace[336467473] 'agreement among raft nodes before linearized reading' (duration: 280.985586ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:23:55.262063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:23:54.72686Z","time spent":"535.194826ms","remote":"127.0.0.1:49104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3740,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-4f907392-34f7-44ec-bc8b-30530b72cd48\" "} {"level":"info","ts":"2026-04-04T10:23:55.262052Z","caller":"traceutil/trace.go:171","msg":"trace[1445202661] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5105; }","duration":"167.494692ms","start":"2026-04-04T10:23:55.094534Z","end":"2026-04-04T10:23:55.262029Z","steps":["trace[1445202661] 'agreement among raft nodes before linearized reading' (duration: 167.366409ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:23:55.262831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"510.130293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-04T10:23:55.262931Z","caller":"traceutil/trace.go:171","msg":"trace[499721520] range","detail":"{range_begin:/registry/cert-manager.io/issuers/; range_end:/registry/cert-manager.io/issuers0; response_count:0; response_revision:5105; }","duration":"510.293217ms","start":"2026-04-04T10:23:54.752609Z","end":"2026-04-04T10:23:55.262902Z","steps":["trace[499721520] 'agreement among raft nodes before linearized reading' (duration: 509.228467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:23:55.262981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:23:54.752583Z","time spent":"510.38742ms","remote":"127.0.0.1:48418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":2,"response size":30,"request content":"key:\"/registry/cert-manager.io/issuers/\" range_end:\"/registry/cert-manager.io/issuers0\" count_only:true "} {"level":"info","ts":"2026-04-04T10:24:04.796078Z","caller":"traceutil/trace.go:171","msg":"trace[474502781] transaction","detail":"{read_only:false; response_revision:5293; number_of_response:1; }","duration":"141.898683ms","start":"2026-04-04T10:24:04.654145Z","end":"2026-04-04T10:24:04.796043Z","steps":["trace[474502781] 'process raft request' (duration: 141.697747ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:04.93404Z","caller":"traceutil/trace.go:171","msg":"trace[1029871560] transaction","detail":"{read_only:false; response_revision:5294; number_of_response:1; }","duration":"136.635702ms","start":"2026-04-04T10:24:04.797361Z","end":"2026-04-04T10:24:04.933997Z","steps":["trace[1029871560] 'process raft request' (duration: 77.724344ms)","trace[1029871560] 'compare' (duration: 58.715633ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:24:04.977364Z","caller":"traceutil/trace.go:171","msg":"trace[1586332380] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"170.22885ms","start":"2026-04-04T10:24:04.807107Z","end":"2026-04-04T10:24:04.977336Z","steps":["trace[1586332380] 'process raft request' (duration: 170.058465ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:05.139364Z","caller":"traceutil/trace.go:171","msg":"trace[1268000420] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"154.534463ms","start":"2026-04-04T10:24:04.984804Z","end":"2026-04-04T10:24:05.139338Z","steps":["trace[1268000420] 'process raft request' (duration: 137.851188ms)","trace[1268000420] 'compare' (duration: 16.497249ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:24:05.139519Z","caller":"traceutil/trace.go:171","msg":"trace[1104458669] linearizableReadLoop","detail":"{readStateIndex:5502; appliedIndex:5500; }","duration":"116.442898ms","start":"2026-04-04T10:24:05.023031Z","end":"2026-04-04T10:24:05.139474Z","steps":["trace[1104458669] 'read index received' (duration: 99.67751ms)","trace[1104458669] 'applied index is now lower than readState.Index' (duration: 16.762018ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:24:05.139586Z","caller":"traceutil/trace.go:171","msg":"trace[1079519607] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"153.271157ms","start":"2026-04-04T10:24:04.986287Z","end":"2026-04-04T10:24:05.139558Z","steps":["trace[1079519607] 'process raft request' (duration: 152.993559ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:24:05.139943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.913482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-w7nt2\" ","response":"range_response_count:1 size:9897"} {"level":"info","ts":"2026-04-04T10:24:05.140055Z","caller":"traceutil/trace.go:171","msg":"trace[1687406698] range","detail":"{range_begin:/registry/pods/monitoring/kube-prometheus-stack-prometheus-node-exporter-w7nt2; range_end:; response_count:1; response_revision:5299; }","duration":"156.086367ms","start":"2026-04-04T10:24:04.983941Z","end":"2026-04-04T10:24:05.140028Z","steps":["trace[1687406698] 'agreement among raft nodes before linearized reading' (duration: 155.712077ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:24:05.159327Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.603475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:24:05.159343Z","caller":"traceutil/trace.go:171","msg":"trace[1270089167] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"131.792495ms","start":"2026-04-04T10:24:05.027512Z","end":"2026-04-04T10:24:05.159305Z","steps":["trace[1270089167] 'process raft request' (duration: 131.522267ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:05.159409Z","caller":"traceutil/trace.go:171","msg":"trace[1463902338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5301; }","duration":"134.742108ms","start":"2026-04-04T10:24:05.024648Z","end":"2026-04-04T10:24:05.15939Z","steps":["trace[1463902338] 'agreement among raft nodes before linearized reading' (duration: 134.593394ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:05.159367Z","caller":"traceutil/trace.go:171","msg":"trace[1214236063] transaction","detail":"{read_only:false; response_revision:5301; number_of_response:1; }","duration":"131.558058ms","start":"2026-04-04T10:24:05.027786Z","end":"2026-04-04T10:24:05.159344Z","steps":["trace[1214236063] 'process raft request' (duration: 131.377183ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:24:05.568687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.532359ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-04T10:24:05.5689Z","caller":"traceutil/trace.go:171","msg":"trace[317594399] transaction","detail":"{read_only:false; response_revision:5302; number_of_response:1; }","duration":"418.688948ms","start":"2026-04-04T10:24:05.150183Z","end":"2026-04-04T10:24:05.568872Z","steps":["trace[317594399] 'process raft request' (duration: 102.878791ms)","trace[317594399] 'compare' (duration: 315.412706ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:24:05.570074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:24:05.150137Z","time spent":"419.886401ms","remote":"127.0.0.1:49104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9519,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:24:05.57042Z","caller":"traceutil/trace.go:171","msg":"trace[2121487477] transaction","detail":"{read_only:false; response_revision:5303; number_of_response:1; }","duration":"246.382969ms","start":"2026-04-04T10:24:05.323982Z","end":"2026-04-04T10:24:05.570365Z","steps":["trace[2121487477] 'process raft request' (duration: 244.817165ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:05.792569Z","caller":"traceutil/trace.go:171","msg":"trace[1573772473] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"443.103943ms","start":"2026-04-04T10:24:05.349431Z","end":"2026-04-04T10:24:05.792535Z","steps":["trace[1573772473] 'process raft request' (duration: 413.734926ms)","trace[1573772473] 'compare' (duration: 29.218813ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:24:05.792744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:24:05.34941Z","time spent":"443.248017ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-04T10:24:05.80309Z","caller":"traceutil/trace.go:171","msg":"trace[1238311354] linearizableReadLoop","detail":"{readStateIndex:5510; appliedIndex:5506; }","duration":"134.837721ms","start":"2026-04-04T10:24:05.668229Z","end":"2026-04-04T10:24:05.803066Z","steps":["trace[1238311354] 'read index received' (duration: 94.936865ms)","trace[1238311354] 'applied index is now lower than readState.Index' (duration: 39.899776ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:24:05.803172Z","caller":"traceutil/trace.go:171","msg":"trace[599089246] transaction","detail":"{read_only:false; response_revision:5306; number_of_response:1; }","duration":"229.228619ms","start":"2026-04-04T10:24:05.573915Z","end":"2026-04-04T10:24:05.803143Z","steps":["trace[599089246] 'process raft request' (duration: 229.060114ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:05.8031Z","caller":"traceutil/trace.go:171","msg":"trace[1589713510] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"229.977261ms","start":"2026-04-04T10:24:05.573089Z","end":"2026-04-04T10:24:05.803066Z","steps":["trace[1589713510] 'process raft request' (duration: 229.752455ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:05.803319Z","caller":"traceutil/trace.go:171","msg":"trace[1024222500] transaction","detail":"{read_only:false; response_revision:5307; number_of_response:1; }","duration":"226.115432ms","start":"2026-04-04T10:24:05.577193Z","end":"2026-04-04T10:24:05.803308Z","steps":["trace[1024222500] 'process raft request' (duration: 225.833393ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:24:05.80339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.14137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-04T10:24:05.803454Z","caller":"traceutil/trace.go:171","msg":"trace[1859841476] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:5307; }","duration":"135.251693ms","start":"2026-04-04T10:24:05.668185Z","end":"2026-04-04T10:24:05.803436Z","steps":["trace[1859841476] 'agreement among raft nodes before linearized reading' (duration: 135.12491ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:24:26.062965Z","caller":"traceutil/trace.go:171","msg":"trace[1695485665] transaction","detail":"{read_only:false; response_revision:5641; number_of_response:1; }","duration":"102.764595ms","start":"2026-04-04T10:24:25.960147Z","end":"2026-04-04T10:24:26.062912Z","steps":["trace[1695485665] 'process raft request' (duration: 76.415545ms)","trace[1695485665] 'compare' (duration: 26.140914ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:25:18.998809Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3005} {"level":"info","ts":"2026-04-04T10:25:19.080133Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3005,"took":"79.514084ms","hash":2288721302,"current-db-size-bytes":58089472,"current-db-size":"58 MB","current-db-size-in-use-bytes":31506432,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-04T10:25:19.080202Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2288721302,"revision":3005,"compact-revision":-1} {"level":"warn","ts":"2026-04-04T10:30:08.471973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.463314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-04T10:30:08.472097Z","caller":"traceutil/trace.go:171","msg":"trace[1911794074] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8245; }","duration":"153.617529ms","start":"2026-04-04T10:30:08.318452Z","end":"2026-04-04T10:30:08.47207Z","steps":["trace[1911794074] 'range keys from in-memory index tree' (duration: 153.28696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:30:08.472166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.067951ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"warn","ts":"2026-04-04T10:30:08.472227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.488832ms","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-04T10:30:08.472299Z","caller":"traceutil/trace.go:171","msg":"trace[103201295] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8245; }","duration":"403.586635ms","start":"2026-04-04T10:30:08.068692Z","end":"2026-04-04T10:30:08.472279Z","steps":["trace[103201295] 'range keys from in-memory index tree' (duration: 403.367918ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:30:08.47229Z","caller":"traceutil/trace.go:171","msg":"trace[1125996541] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8245; }","duration":"108.238236ms","start":"2026-04-04T10:30:08.364022Z","end":"2026-04-04T10:30:08.47226Z","steps":["trace[1125996541] 'range keys from in-memory index tree' (duration: 107.854296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:30:08.47232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.460585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-04-04T10:30:08.472363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:30:08.068674Z","time spent":"403.654966ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-04-04T10:30:08.472394Z","caller":"traceutil/trace.go:171","msg":"trace[2075791603] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8245; }","duration":"407.571709ms","start":"2026-04-04T10:30:08.064802Z","end":"2026-04-04T10:30:08.472374Z","steps":["trace[2075791603] 'range keys from in-memory index tree' (duration: 407.348162ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:30:08.472436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-04T10:30:08.064784Z","time spent":"407.64418ms","remote":"127.0.0.1:49176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-04T10:30:19.217323Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6088} {"level":"warn","ts":"2026-04-04T10:30:19.21761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.536908ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:5"} {"level":"info","ts":"2026-04-04T10:30:19.217692Z","caller":"traceutil/trace.go:171","msg":"trace[2023088090] linearizableReadLoop","detail":"{readStateIndex:8601; appliedIndex:8600; }","duration":"158.802067ms","start":"2026-04-04T10:30:19.058877Z","end":"2026-04-04T10:30:19.217679Z","steps":["trace[2023088090] 'read index received' (duration: 5.332222ms)","trace[2023088090] 'applied index is now lower than readState.Index' (duration: 153.468745ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:30:19.217774Z","caller":"traceutil/trace.go:171","msg":"trace[973263759] compact","detail":"{revision:6088; response_revision:8304; }","duration":"176.82347ms","start":"2026-04-04T10:30:19.040914Z","end":"2026-04-04T10:30:19.217738Z","steps":["trace[973263759] 'check and update compact revision' (duration: 152.448525ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:30:19.217868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.964272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-04T10:30:19.217917Z","caller":"traceutil/trace.go:171","msg":"trace[1650081520] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:8304; }","duration":"159.068755ms","start":"2026-04-04T10:30:19.058828Z","end":"2026-04-04T10:30:19.217897Z","steps":["trace[1650081520] 'agreement among raft nodes before linearized reading' (duration: 158.890029ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:30:19.869565Z","caller":"traceutil/trace.go:171","msg":"trace[210072052] transaction","detail":"{read_only:false; response_revision:8306; number_of_response:1; }","duration":"214.103453ms","start":"2026-04-04T10:30:19.65544Z","end":"2026-04-04T10:30:19.869544Z","steps":["trace[210072052] 'process raft request' (duration: 206.485327ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:30:19.950094Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6088,"took":"729.68152ms","hash":1487019290,"current-db-size-bytes":58089472,"current-db-size":"58 MB","current-db-size-in-use-bytes":23330816,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-04T10:30:19.950182Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1487019290,"revision":6088,"compact-revision":3005} {"level":"info","ts":"2026-04-04T10:30:19.950554Z","caller":"traceutil/trace.go:171","msg":"trace[246536223] transaction","detail":"{read_only:false; response_revision:8307; number_of_response:1; }","duration":"208.145103ms","start":"2026-04-04T10:30:19.742358Z","end":"2026-04-04T10:30:19.950503Z","steps":["trace[246536223] 'process raft request' (duration: 144.883681ms)","trace[246536223] 'compare' (duration: 62.950914ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:30:20.710604Z","caller":"traceutil/trace.go:171","msg":"trace[541495999] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"166.24176ms","start":"2026-04-04T10:30:20.544327Z","end":"2026-04-04T10:30:20.710569Z","steps":["trace[541495999] 'process raft request' (duration: 166.066155ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:30:20.710857Z","caller":"traceutil/trace.go:171","msg":"trace[1338311593] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"167.233177ms","start":"2026-04-04T10:30:20.543587Z","end":"2026-04-04T10:30:20.71082Z","steps":["trace[1338311593] 'process raft request' (duration: 166.587258ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:30:49.446346Z","caller":"traceutil/trace.go:171","msg":"trace[1991096941] linearizableReadLoop","detail":"{readStateIndex:8825; appliedIndex:8824; }","duration":"193.615609ms","start":"2026-04-04T10:30:49.252695Z","end":"2026-04-04T10:30:49.446311Z","steps":["trace[1991096941] 'read index received' (duration: 193.479285ms)","trace[1991096941] 'applied index is now lower than readState.Index' (duration: 134.814µs)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:30:49.446715Z","caller":"traceutil/trace.go:171","msg":"trace[677871954] transaction","detail":"{read_only:false; response_revision:8520; number_of_response:1; }","duration":"276.755058ms","start":"2026-04-04T10:30:49.169946Z","end":"2026-04-04T10:30:49.446701Z","steps":["trace[677871954] 'process raft request' (duration: 276.161391ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:30:49.447086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.348891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-04T10:30:49.447179Z","caller":"traceutil/trace.go:171","msg":"trace[1922342692] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8520; }","duration":"194.472564ms","start":"2026-04-04T10:30:49.252651Z","end":"2026-04-04T10:30:49.447123Z","steps":["trace[1922342692] 'agreement among raft nodes before linearized reading' (duration: 194.278689ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:30:49.660088Z","caller":"traceutil/trace.go:171","msg":"trace[1771593499] transaction","detail":"{read_only:false; response_revision:8521; number_of_response:1; }","duration":"264.074629ms","start":"2026-04-04T10:30:49.395981Z","end":"2026-04-04T10:30:49.660055Z","steps":["trace[1771593499] 'process raft request' (duration: 224.051417ms)","trace[1771593499] 'compare' (duration: 39.309061ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:30:49.660384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.331447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-04T10:30:49.660484Z","caller":"traceutil/trace.go:171","msg":"trace[768181457] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8521; }","duration":"290.493391ms","start":"2026-04-04T10:30:49.369963Z","end":"2026-04-04T10:30:49.660456Z","steps":["trace[768181457] 'agreement among raft nodes before linearized reading' (duration: 290.333397ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:30:49.660011Z","caller":"traceutil/trace.go:171","msg":"trace[340876788] linearizableReadLoop","detail":"{readStateIndex:8826; appliedIndex:8825; }","duration":"213.521688ms","start":"2026-04-04T10:30:49.446452Z","end":"2026-04-04T10:30:49.659974Z","steps":["trace[340876788] 'read index received' (duration: 173.531597ms)","trace[340876788] 'applied index is now lower than readState.Index' (duration: 39.988211ms)"],"step_count":2} {"level":"warn","ts":"2026-04-04T10:30:49.660821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.697578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-04-04T10:30:49.660873Z","caller":"traceutil/trace.go:171","msg":"trace[242147243] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8521; }","duration":"209.794261ms","start":"2026-04-04T10:30:49.451063Z","end":"2026-04-04T10:30:49.660858Z","steps":["trace[242147243] 'agreement among raft nodes before linearized reading' (duration: 209.574395ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:02.022043Z","caller":"traceutil/trace.go:171","msg":"trace[1830596937] linearizableReadLoop","detail":"{readStateIndex:8936; appliedIndex:8935; }","duration":"110.141716ms","start":"2026-04-04T10:31:01.911873Z","end":"2026-04-04T10:31:02.022015Z","steps":["trace[1830596937] 'read index received' (duration: 110.010403ms)","trace[1830596937] 'applied index is now lower than readState.Index' (duration: 129.953µs)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:31:02.022191Z","caller":"traceutil/trace.go:171","msg":"trace[1211295069] transaction","detail":"{read_only:false; response_revision:8626; number_of_response:1; }","duration":"156.496656ms","start":"2026-04-04T10:31:01.865634Z","end":"2026-04-04T10:31:02.02213Z","steps":["trace[1211295069] 'process raft request' (duration: 156.209848ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:31:02.022743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.844317ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-04T10:31:02.022822Z","caller":"traceutil/trace.go:171","msg":"trace[1670119202] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:8626; }","duration":"111.019842ms","start":"2026-04-04T10:31:01.911784Z","end":"2026-04-04T10:31:02.022804Z","steps":["trace[1670119202] 'agreement among raft nodes before linearized reading' (duration: 110.875478ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:02.192305Z","caller":"traceutil/trace.go:171","msg":"trace[184787565] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"145.090473ms","start":"2026-04-04T10:31:02.047187Z","end":"2026-04-04T10:31:02.192277Z","steps":["trace[184787565] 'process raft request' (duration: 100.175534ms)","trace[184787565] 'compare' (duration: 44.556919ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:31:02.211241Z","caller":"traceutil/trace.go:171","msg":"trace[756522517] transaction","detail":"{read_only:false; response_revision:8629; number_of_response:1; }","duration":"123.202769ms","start":"2026-04-04T10:31:02.088009Z","end":"2026-04-04T10:31:02.211212Z","steps":["trace[756522517] 'process raft request' (duration: 123.143388ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:02.211493Z","caller":"traceutil/trace.go:171","msg":"trace[1139575136] transaction","detail":"{read_only:false; response_revision:8628; number_of_response:1; }","duration":"158.383971ms","start":"2026-04-04T10:31:02.053028Z","end":"2026-04-04T10:31:02.211412Z","steps":["trace[1139575136] 'process raft request' (duration: 157.971679ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:02.985935Z","caller":"traceutil/trace.go:171","msg":"trace[1827803224] transaction","detail":"{read_only:false; response_revision:8634; number_of_response:1; }","duration":"156.122516ms","start":"2026-04-04T10:31:02.829782Z","end":"2026-04-04T10:31:02.985905Z","steps":["trace[1827803224] 'process raft request' (duration: 155.937111ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:03.081222Z","caller":"traceutil/trace.go:171","msg":"trace[585197256] linearizableReadLoop","detail":"{readStateIndex:8946; appliedIndex:8944; }","duration":"192.750649ms","start":"2026-04-04T10:31:02.88844Z","end":"2026-04-04T10:31:03.081191Z","steps":["trace[585197256] 'read index received' (duration: 97.28513ms)","trace[585197256] 'applied index is now lower than readState.Index' (duration: 95.464239ms)"],"step_count":2} {"level":"info","ts":"2026-04-04T10:31:03.081324Z","caller":"traceutil/trace.go:171","msg":"trace[2130921428] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"237.644299ms","start":"2026-04-04T10:31:02.84365Z","end":"2026-04-04T10:31:03.081295Z","steps":["trace[2130921428] 'process raft request' (duration: 237.275418ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:31:03.081546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.087259ms","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-04T10:31:03.081604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.360046ms","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-04T10:31:03.081625Z","caller":"traceutil/trace.go:171","msg":"trace[656791080] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8635; }","duration":"193.222373ms","start":"2026-04-04T10:31:02.888385Z","end":"2026-04-04T10:31:03.081607Z","steps":["trace[656791080] 'agreement among raft nodes before linearized reading' (duration: 192.995847ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:03.081669Z","caller":"traceutil/trace.go:171","msg":"trace[1522797259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8635; }","duration":"168.452209ms","start":"2026-04-04T10:31:02.913204Z","end":"2026-04-04T10:31:03.081657Z","steps":["trace[1522797259] 'agreement among raft nodes before linearized reading' (duration: 168.228632ms)"],"step_count":1} {"level":"warn","ts":"2026-04-04T10:31:03.081723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.835798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"warn","ts":"2026-04-04T10:31:03.08168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.27829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-04-04T10:31:03.081938Z","caller":"traceutil/trace.go:171","msg":"trace[2075081603] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8635; }","duration":"157.557709ms","start":"2026-04-04T10:31:02.924361Z","end":"2026-04-04T10:31:03.081919Z","steps":["trace[2075081603] 'agreement among raft nodes before linearized reading' (duration: 157.205849ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:03.081818Z","caller":"traceutil/trace.go:171","msg":"trace[171655033] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8635; }","duration":"163.979322ms","start":"2026-04-04T10:31:02.91782Z","end":"2026-04-04T10:31:03.081799Z","steps":["trace[171655033] 'agreement among raft nodes before linearized reading' (duration: 163.748775ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:31:45.642954Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024b9.wal"} {"level":"info","ts":"2026-04-04T10:32:01.600987Z","caller":"traceutil/trace.go:171","msg":"trace[1046546599] transaction","detail":"{read_only:false; response_revision:9257; number_of_response:1; }","duration":"133.028919ms","start":"2026-04-04T10:32:01.4678Z","end":"2026-04-04T10:32:01.600829Z","steps":["trace[1046546599] 'process raft request' (duration: 132.829264ms)"],"step_count":1} {"level":"info","ts":"2026-04-04T10:32:54.921081Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"89ba38f964b95aa0","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-04T10:32:54.928325Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-04T10:32:54.928397Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-04T10:35:19.225008Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8303} {"level":"info","ts":"2026-04-04T10:35:19.30867Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8303,"took":"80.446482ms","hash":440410871,"current-db-size-bytes":58089472,"current-db-size":"58 MB","current-db-size-in-use-bytes":25878528,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-04T10:35:19.308898Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":440410871,"revision":8303,"compact-revision":6088} {"level":"info","ts":"2026-04-04T10:40:19.230894Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10702} {"level":"info","ts":"2026-04-04T10:40:19.316343Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10702,"took":"79.851154ms","hash":1739421975,"current-db-size-bytes":58089472,"current-db-size":"58 MB","current-db-size-in-use-bytes":20987904,"current-db-size-in-use":"21 MB"} {"level":"info","ts":"2026-04-04T10:40:19.316455Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1739421975,"revision":10702,"compact-revision":8303}